{"level":"warn","ts":"2026-03-25T21:05:31.800277Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-25T21:05:31.800368Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-25T21:05:31.800435Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-25T21:05:31.800447Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]}
{"level":"info","ts":"2026-03-25T21:05:31.800469Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-25T21:05:31.801127Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]}
{"level":"info","ts":"2026-03-25T21:05:31.801204Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-25T21:05:31.804607Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.186774ms"}
{"level":"info","ts":"2026-03-25T21:05:31.811224Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"}
{"level":"info","ts":"2026-03-25T21:05:31.811297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"}
{"level":"info","ts":"2026-03-25T21:05:31.81132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"}
{"level":"info","ts":"2026-03-25T21:05:31.811334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-25T21:05:31.811346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"}
{"level":"info","ts":"2026-03-25T21:05:31.811389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"}
{"level":"warn","ts":"2026-03-25T21:05:31.821992Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-25T21:05:31.823317Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-25T21:05:31.824295Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-25T21:05:31.82628Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-25T21:05:31.827231Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-25T21:05:31.82934Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-25T21:05:31.829422Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-25T21:05:31.829433Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-25T21:05:31.829911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"}
{"level":"info","ts":"2026-03-25T21:05:31.830237Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]}
{"level":"info","ts":"2026-03-25T21:05:31.831673Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-25T21:05:31.831918Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-25T21:05:31.831943Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-25T21:05:31.832006Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"}
{"level":"info","ts":"2026-03-25T21:05:31.832022Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"}
{"level":"info","ts":"2026-03-25T21:05:32.011916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"}
{"level":"info","ts":"2026-03-25T21:05:32.012026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-25T21:05:32.012055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"}
{"level":"info","ts":"2026-03-25T21:05:32.012071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"}
{"level":"info","ts":"2026-03-25T21:05:32.012078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"}
{"level":"info","ts":"2026-03-25T21:05:32.012089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"}
{"level":"info","ts":"2026-03-25T21:05:32.0121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"}
{"level":"info","ts":"2026-03-25T21:05:32.017285Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-25T21:05:32.017287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-25T21:05:32.017319Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T21:05:32.017438Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-25T21:05:32.017578Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-25T21:05:32.017666Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-25T21:05:32.018281Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T21:05:32.018468Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T21:05:32.018531Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T21:05:32.033396Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"}
{"level":"info","ts":"2026-03-25T21:05:32.03362Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-25T21:06:03.504856Z","caller":"traceutil/trace.go:171","msg":"trace[1109488844] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"269.939406ms","start":"2026-03-25T21:06:03.234883Z","end":"2026-03-25T21:06:03.504823Z","steps":["trace[1109488844] 'read index received'  (duration: 264.787197ms)","trace[1109488844] 'applied index is now lower than readState.Index'  (duration: 5.151189ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T21:06:03.505341Z","caller":"traceutil/trace.go:171","msg":"trace[2060156616] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"271.16853ms","start":"2026-03-25T21:06:03.234135Z","end":"2026-03-25T21:06:03.505304Z","steps":["trace[2060156616] 'process raft request'  (duration: 265.632051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:06:03.505731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.779828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-25T21:06:03.505943Z","caller":"traceutil/trace.go:171","msg":"trace[590211447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"271.072896ms","start":"2026-03-25T21:06:03.234838Z","end":"2026-03-25T21:06:03.505911Z","steps":["trace[590211447] 'agreement among raft nodes before linearized reading'  (duration: 270.493251ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:06:03.507149Z","caller":"traceutil/trace.go:171","msg":"trace[1251988630] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"241.890482ms","start":"2026-03-25T21:06:03.265208Z","end":"2026-03-25T21:06:03.507099Z","steps":["trace[1251988630] 'process raft request'  (duration: 241.697397ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:06:03.507161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.876846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-25T21:06:03.507205Z","caller":"traceutil/trace.go:171","msg":"trace[226552273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"137.942928ms","start":"2026-03-25T21:06:03.369251Z","end":"2026-03-25T21:06:03.507194Z","steps":["trace[226552273] 'agreement among raft nodes before linearized reading'  (duration: 137.824265ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:06:10.794675Z","caller":"traceutil/trace.go:171","msg":"trace[1329250758] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"107.923401ms","start":"2026-03-25T21:06:10.686727Z","end":"2026-03-25T21:06:10.79465Z","steps":["trace[1329250758] 'read index received'  (duration: 107.660464ms)","trace[1329250758] 'applied index is now lower than readState.Index'  (duration: 262.177µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T21:06:10.794818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.059944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T21:06:10.794848Z","caller":"traceutil/trace.go:171","msg":"trace[631916633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"108.191548ms","start":"2026-03-25T21:06:10.686647Z","end":"2026-03-25T21:06:10.794838Z","steps":["trace[631916633] 'agreement among raft nodes before linearized reading'  (duration: 108.102085ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:06:10.794794Z","caller":"traceutil/trace.go:171","msg":"trace[965744978] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"111.62556ms","start":"2026-03-25T21:06:10.683088Z","end":"2026-03-25T21:06:10.794713Z","steps":["trace[965744978] 'process raft request'  (duration: 111.377324ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:06:11.268402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.680039ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9088155363099584546 > lease_revoke:<id:7e1f9d26d11ca6e5>","response":"size:28"}
{"level":"info","ts":"2026-03-25T21:06:25.803131Z","caller":"traceutil/trace.go:171","msg":"trace[771981897] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"134.945538ms","start":"2026-03-25T21:06:25.668158Z","end":"2026-03-25T21:06:25.803104Z","steps":["trace[771981897] 'process raft request'  (duration: 134.744002ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:06:25.819919Z","caller":"traceutil/trace.go:171","msg":"trace[2021815699] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"129.865702ms","start":"2026-03-25T21:06:25.690026Z","end":"2026-03-25T21:06:25.819891Z","steps":["trace[2021815699] 'read index received'  (duration: 116.528223ms)","trace[2021815699] 'applied index is now lower than readState.Index'  (duration: 13.335949ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T21:06:25.820281Z","caller":"traceutil/trace.go:171","msg":"trace[227014287] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"151.900313ms","start":"2026-03-25T21:06:25.668367Z","end":"2026-03-25T21:06:25.820267Z","steps":["trace[227014287] 'process raft request'  (duration: 151.376549ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:06:25.820477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.066734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-03-25T21:06:25.820466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.401006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T21:06:25.820533Z","caller":"traceutil/trace.go:171","msg":"trace[519460267] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; response_count:1; response_revision:782; }","duration":"105.170827ms","start":"2026-03-25T21:06:25.71535Z","end":"2026-03-25T21:06:25.82052Z","steps":["trace[519460267] 'agreement among raft nodes before linearized reading'  (duration: 104.980362ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:06:25.820563Z","caller":"traceutil/trace.go:171","msg":"trace[28538098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:782; }","duration":"130.54683ms","start":"2026-03-25T21:06:25.689989Z","end":"2026-03-25T21:06:25.820536Z","steps":["trace[28538098] 'agreement among raft nodes before linearized reading'  (duration: 130.364725ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:07:01.004238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.648273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T21:07:01.004337Z","caller":"traceutil/trace.go:171","msg":"trace[217577045] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1000; }","duration":"127.798987ms","start":"2026-03-25T21:07:00.876518Z","end":"2026-03-25T21:07:01.004317Z","steps":["trace[217577045] 'count revisions from in-memory index tree'  (duration: 127.585481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:07:01.004319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.007647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-25T21:07:01.004731Z","caller":"traceutil/trace.go:171","msg":"trace[1046181910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1000; }","duration":"107.430118ms","start":"2026-03-25T21:07:00.897284Z","end":"2026-03-25T21:07:01.004714Z","steps":["trace[1046181910] 'range keys from in-memory index tree'  (duration: 106.895994ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:01.134606Z","caller":"traceutil/trace.go:171","msg":"trace[325044292] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"125.75197ms","start":"2026-03-25T21:07:01.008828Z","end":"2026-03-25T21:07:01.13458Z","steps":["trace[325044292] 'process raft request'  (duration: 125.558864ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:01.143366Z","caller":"traceutil/trace.go:171","msg":"trace[1828631811] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"120.478283ms","start":"2026-03-25T21:07:01.022828Z","end":"2026-03-25T21:07:01.143306Z","steps":["trace[1828631811] 'process raft request'  (duration: 120.294518ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:25.531954Z","caller":"traceutil/trace.go:171","msg":"trace[873401959] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1119; }","duration":"113.711174ms","start":"2026-03-25T21:07:25.418216Z","end":"2026-03-25T21:07:25.531928Z","steps":["trace[873401959] 'read index received'  (duration: 54.83354ms)","trace[873401959] 'applied index is now lower than readState.Index'  (duration: 58.876354ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T21:07:25.532075Z","caller":"traceutil/trace.go:171","msg":"trace[535929378] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"166.781816ms","start":"2026-03-25T21:07:25.365261Z","end":"2026-03-25T21:07:25.532042Z","steps":["trace[535929378] 'process raft request'  (duration: 107.859961ms)","trace[535929378] 'compare'  (duration: 58.692269ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T21:07:25.532115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.880409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T21:07:25.532154Z","caller":"traceutil/trace.go:171","msg":"trace[398828200] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1080; }","duration":"113.988222ms","start":"2026-03-25T21:07:25.418153Z","end":"2026-03-25T21:07:25.532142Z","steps":["trace[398828200] 'agreement among raft nodes before linearized reading'  (duration: 113.869888ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:38.356364Z","caller":"traceutil/trace.go:171","msg":"trace[539014828] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1217; }","duration":"134.516125ms","start":"2026-03-25T21:07:38.221831Z","end":"2026-03-25T21:07:38.356347Z","steps":["trace[539014828] 'read index received'  (duration: 134.418712ms)","trace[539014828] 'applied index is now lower than readState.Index'  (duration: 96.883µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T21:07:38.356542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.692989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-25T21:07:38.356598Z","caller":"traceutil/trace.go:171","msg":"trace[1799989374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1173; }","duration":"134.788252ms","start":"2026-03-25T21:07:38.221795Z","end":"2026-03-25T21:07:38.356583Z","steps":["trace[1799989374] 'agreement among raft nodes before linearized reading'  (duration: 134.623028ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:38.356788Z","caller":"traceutil/trace.go:171","msg":"trace[1943142706] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"137.197009ms","start":"2026-03-25T21:07:38.219576Z","end":"2026-03-25T21:07:38.356773Z","steps":["trace[1943142706] 'process raft request'  (duration: 136.668735ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:53.807497Z","caller":"traceutil/trace.go:171","msg":"trace[2114631322] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"102.750957ms","start":"2026-03-25T21:07:53.704722Z","end":"2026-03-25T21:07:53.807473Z","steps":["trace[2114631322] 'process raft request'  (duration: 102.084179ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:54.03503Z","caller":"traceutil/trace.go:171","msg":"trace[1559781981] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"219.049514ms","start":"2026-03-25T21:07:53.815946Z","end":"2026-03-25T21:07:54.034995Z","steps":["trace[1559781981] 'process raft request'  (duration: 218.815998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T21:07:54.372413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.422609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-v89b2\" ","response":"range_response_count:1 size:11057"}
{"level":"info","ts":"2026-03-25T21:07:54.372497Z","caller":"traceutil/trace.go:171","msg":"trace[85140652] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-v89b2; range_end:; response_count:1; response_revision:1240; }","duration":"284.552193ms","start":"2026-03-25T21:07:54.087925Z","end":"2026-03-25T21:07:54.372477Z","steps":["trace[85140652] 'range keys from in-memory index tree'  (duration: 284.245764ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:54.733298Z","caller":"traceutil/trace.go:171","msg":"trace[1226282894] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"177.966408ms","start":"2026-03-25T21:07:54.555304Z","end":"2026-03-25T21:07:54.733271Z","steps":["trace[1226282894] 'process raft request'  (duration: 83.145891ms)","trace[1226282894] 'compare'  (duration: 94.521088ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T21:07:54.986674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.48974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9088155363099585944 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1230 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T21:07:54.986998Z","caller":"traceutil/trace.go:171","msg":"trace[40138562] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"167.758843ms","start":"2026-03-25T21:07:54.819218Z","end":"2026-03-25T21:07:54.986977Z","steps":["trace[40138562] 'process raft request'  (duration: 25.44588ms)","trace[40138562] 'compare'  (duration: 141.358206ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T21:07:55.505494Z","caller":"traceutil/trace.go:171","msg":"trace[1965544012] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1298; }","duration":"206.601006ms","start":"2026-03-25T21:07:55.298869Z","end":"2026-03-25T21:07:55.50547Z","steps":["trace[1965544012] 'read index received'  (duration: 138.677671ms)","trace[1965544012] 'applied index is now lower than readState.Index'  (duration: 67.922095ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T21:07:55.505716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.831033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-25T21:07:55.505759Z","caller":"traceutil/trace.go:171","msg":"trace[1828214460] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1252; }","duration":"206.941776ms","start":"2026-03-25T21:07:55.298806Z","end":"2026-03-25T21:07:55.505747Z","steps":["trace[1828214460] 'agreement among raft nodes before linearized reading'  (duration: 206.757311ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:55.505766Z","caller":"traceutil/trace.go:171","msg":"trace[1782180347] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"240.42111ms","start":"2026-03-25T21:07:55.265314Z","end":"2026-03-25T21:07:55.505735Z","steps":["trace[1782180347] 'process raft request'  (duration: 172.127494ms)","trace[1782180347] 'compare'  (duration: 67.865734ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T21:07:55.505894Z","caller":"traceutil/trace.go:171","msg":"trace[1868759666] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"235.509995ms","start":"2026-03-25T21:07:55.270374Z","end":"2026-03-25T21:07:55.505884Z","steps":["trace[1868759666] 'process raft request'  (duration: 235.048691ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:55.507128Z","caller":"traceutil/trace.go:171","msg":"trace[399910928] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"207.438761ms","start":"2026-03-25T21:07:55.299672Z","end":"2026-03-25T21:07:55.507111Z","steps":["trace[399910928] 'process raft request'  (duration: 207.369899ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:55.688597Z","caller":"traceutil/trace.go:171","msg":"trace[1971398475] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"178.534144ms","start":"2026-03-25T21:07:55.510036Z","end":"2026-03-25T21:07:55.68857Z","steps":["trace[1971398475] 'process raft request'  (duration: 143.2957ms)","trace[1971398475] 'compare'  (duration: 35.060429ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T21:07:55.694742Z","caller":"traceutil/trace.go:171","msg":"trace[175243197] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"173.528264ms","start":"2026-03-25T21:07:55.52118Z","end":"2026-03-25T21:07:55.694708Z","steps":["trace[175243197] 'process raft request'  (duration: 173.476512ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T21:07:55.695185Z","caller":"traceutil/trace.go:171","msg":"trace[1335662818] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"183.370808ms","start":"2026-03-25T21:07:55.511748Z","end":"2026-03-25T21:07:55.695119Z","steps":["trace[1335662818] 'process raft request'  (duration: 182.71731ms)"],"step_count":1}