{"level":"warn","ts":"2026-03-05T06:35:54.516184Z","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-05T06:35:54.516288Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.209: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://162.253.55.209:2380","--initial-cluster=instance=https://162.253.55.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.209: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-05T06:35:54.516351Z","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-05T06:35:54.516365Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.209:2380"]}
{"level":"info","ts":"2026-03-05T06:35:54.516382Z","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-05T06:35:54.517034Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"]}
{"level":"info","ts":"2026-03-05T06:35:54.517112Z","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://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.209: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-05T06:35:54.522879Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.572534ms"}
{"level":"info","ts":"2026-03-05T06:35:54.532637Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"53de2bdd9aa7b793","cluster-id":"385802231390d48c"}
{"level":"info","ts":"2026-03-05T06:35:54.532715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-05T06:35:54.532741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 0"}
{"level":"info","ts":"2026-03-05T06:35:54.532755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 53de2bdd9aa7b793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-05T06:35:54.532768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 1"}
{"level":"info","ts":"2026-03-05T06:35:54.532806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"}
{"level":"warn","ts":"2026-03-05T06:35:54.54093Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-05T06:35:54.542827Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-05T06:35:54.54413Z","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-05T06:35:54.546323Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"53de2bdd9aa7b793","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-05T06:35:54.547352Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"53de2bdd9aa7b793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-05T06:35:54.547736Z","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-05T06:35:54.549449Z","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-05T06:35:54.550088Z","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-05T06:35:54.550606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"}
{"level":"info","ts":"2026-03-05T06:35:54.550815Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","added-peer-id":"53de2bdd9aa7b793","added-peer-peer-urls":["https://162.253.55.209:2380"]}
{"level":"info","ts":"2026-03-05T06:35:54.551506Z","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-05T06:35:54.551689Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"53de2bdd9aa7b793","initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-05T06:35:54.551714Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-05T06:35:54.551811Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.209:2380"}
{"level":"info","ts":"2026-03-05T06:35:54.551826Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.209:2380"}
{"level":"info","ts":"2026-03-05T06:35:55.133591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-05T06:35:55.13369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-05T06:35:55.133735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgPreVoteResp from 53de2bdd9aa7b793 at term 1"}
{"level":"info","ts":"2026-03-05T06:35:55.133762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became candidate at term 2"}
{"level":"info","ts":"2026-03-05T06:35:55.133778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgVoteResp from 53de2bdd9aa7b793 at term 2"}
{"level":"info","ts":"2026-03-05T06:35:55.133794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became leader at term 2"}
{"level":"info","ts":"2026-03-05T06:35:55.133814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 53de2bdd9aa7b793 elected leader 53de2bdd9aa7b793 at term 2"}
{"level":"info","ts":"2026-03-05T06:35:55.134821Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:35:55.135961Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T06:35:55.13596Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"53de2bdd9aa7b793","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.209:2379]}","request-path":"/0/members/53de2bdd9aa7b793/attributes","cluster-id":"385802231390d48c","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-05T06:35:55.13615Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T06:35:55.136336Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-05T06:35:55.136377Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-05T06:35:55.136664Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:35:55.136762Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:35:55.136793Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:35:55.138975Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.209:2379"}
{"level":"info","ts":"2026-03-05T06:35:55.139824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-05T06:35:57.146233Z","caller":"traceutil/trace.go:171","msg":"trace[866530785] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"388.280823ms","start":"2026-03-05T06:35:56.757932Z","end":"2026-03-05T06:35:57.146213Z","steps":["trace[866530785] 'read index received'  (duration: 388.235212ms)","trace[866530785] 'applied index is now lower than readState.Index'  (duration: 44.911µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:35:57.146337Z","caller":"traceutil/trace.go:171","msg":"trace[1816364754] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"390.498422ms","start":"2026-03-05T06:35:56.755789Z","end":"2026-03-05T06:35:57.146287Z","steps":["trace[1816364754] 'process raft request'  (duration: 390.305937ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:35:57.146603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.61632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-05T06:35:57.146713Z","caller":"traceutil/trace.go:171","msg":"trace[1183638056] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:74; }","duration":"388.792984ms","start":"2026-03-05T06:35:56.757896Z","end":"2026-03-05T06:35:57.146689Z","steps":["trace[1183638056] 'agreement among raft nodes before linearized reading'  (duration: 388.419936ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:35:57.146759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:56.757882Z","time spent":"388.866516ms","remote":"127.0.0.1:59528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-03-05T06:35:57.146837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:56.755763Z","time spent":"390.662247ms","remote":"127.0.0.1:59330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"warn","ts":"2026-03-05T06:35:57.854012Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088864834528471,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T06:35:58.354483Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088864834528471,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T06:35:58.460266Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.306583304s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-05T06:35:58.460705Z","caller":"traceutil/trace.go:171","msg":"trace[257141776] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"1.307123896s","start":"2026-03-05T06:35:57.153563Z","end":"2026-03-05T06:35:58.460687Z","steps":["trace[257141776] 'process raft request'  (duration: 1.307009403s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:35:58.460799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:57.15354Z","time spent":"1.307208897s","remote":"127.0.0.1:59528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/csinodes/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/csinodes/instance\" value_size:616 >> failure:<>"}
{"level":"info","ts":"2026-03-05T06:35:58.606666Z","caller":"traceutil/trace.go:171","msg":"trace[2000100113] linearizableReadLoop","detail":"{readStateIndex:80; appliedIndex:78; }","duration":"1.25334865s","start":"2026-03-05T06:35:57.353281Z","end":"2026-03-05T06:35:58.606629Z","steps":["trace[2000100113] 'read index received'  (duration: 1.107391161s)","trace[2000100113] 'applied index is now lower than readState.Index'  (duration: 145.955849ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:35:58.606716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:58.215482Z","time spent":"391.193899ms","remote":"127.0.0.1:59254","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-05T06:35:58.6068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253498783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-05T06:35:58.606845Z","caller":"traceutil/trace.go:171","msg":"trace[80572788] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:75; }","duration":"1.253600055s","start":"2026-03-05T06:35:57.353235Z","end":"2026-03-05T06:35:58.606835Z","steps":["trace[80572788] 'agreement among raft nodes before linearized reading'  (duration: 1.253510013s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:35:58.606874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:57.353215Z","time spent":"1.253652607s","remote":"127.0.0.1:59508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "}
{"level":"warn","ts":"2026-03-05T06:35:58.606994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.285986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"warn","ts":"2026-03-05T06:35:58.607017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.149876556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-05T06:35:58.607025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253602825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-05T06:35:58.607075Z","caller":"traceutil/trace.go:171","msg":"trace[1089422094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:75; }","duration":"115.414119ms","start":"2026-03-05T06:35:58.491641Z","end":"2026-03-05T06:35:58.607055Z","steps":["trace[1089422094] 'agreement among raft nodes before linearized reading'  (duration: 115.240045ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:35:58.607079Z","caller":"traceutil/trace.go:171","msg":"trace[1888465103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"1.149965967s","start":"2026-03-05T06:35:57.457097Z","end":"2026-03-05T06:35:58.607063Z","steps":["trace[1888465103] 'agreement among raft nodes before linearized reading'  (duration: 1.149866475s)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:35:58.607104Z","caller":"traceutil/trace.go:171","msg":"trace[1541243477] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:75; }","duration":"1.253728188s","start":"2026-03-05T06:35:57.353358Z","end":"2026-03-05T06:35:58.607086Z","steps":["trace[1541243477] 'agreement among raft nodes before linearized reading'  (duration: 1.253524803s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:35:58.607133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:57.457079Z","time spent":"1.150043299s","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T06:35:58.607151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:35:57.353344Z","time spent":"1.25379761s","remote":"127.0.0.1:59482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "}
{"level":"warn","ts":"2026-03-05T06:35:58.60719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.643456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-05T06:35:58.607221Z","caller":"traceutil/trace.go:171","msg":"trace[9752058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:75; }","duration":"111.714087ms","start":"2026-03-05T06:35:58.495499Z","end":"2026-03-05T06:35:58.607213Z","steps":["trace[9752058] 'agreement among raft nodes before linearized reading'  (duration: 111.660086ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:30.96874Z","caller":"traceutil/trace.go:171","msg":"trace[1720911680] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"207.148892ms","start":"2026-03-05T06:36:30.761564Z","end":"2026-03-05T06:36:30.968713Z","steps":["trace[1720911680] 'read index received'  (duration: 206.874476ms)","trace[1720911680] 'applied index is now lower than readState.Index'  (duration: 273.336µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:36:30.968853Z","caller":"traceutil/trace.go:171","msg":"trace[724996176] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"212.572752ms","start":"2026-03-05T06:36:30.756229Z","end":"2026-03-05T06:36:30.968802Z","steps":["trace[724996176] 'process raft request'  (duration: 212.276645ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:30.968946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.266847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:36:30.968989Z","caller":"traceutil/trace.go:171","msg":"trace[1098794026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:525; }","duration":"204.351829ms","start":"2026-03-05T06:36:30.764626Z","end":"2026-03-05T06:36:30.968978Z","steps":["trace[1098794026] 'agreement among raft nodes before linearized reading'  (duration: 204.245167ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:30.968977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.360626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-05T06:36:30.969064Z","caller":"traceutil/trace.go:171","msg":"trace[1886111914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:525; }","duration":"207.503889ms","start":"2026-03-05T06:36:30.761534Z","end":"2026-03-05T06:36:30.969038Z","steps":["trace[1886111914] 'agreement among raft nodes before linearized reading'  (duration: 207.316165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:31.422447Z","caller":"traceutil/trace.go:171","msg":"trace[456123843] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"447.764386ms","start":"2026-03-05T06:36:30.974655Z","end":"2026-03-05T06:36:31.42242Z","steps":["trace[456123843] 'process raft request'  (duration: 356.986257ms)","trace[456123843] 'compare'  (duration: 90.676507ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:36:31.422754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:30.974627Z","time spent":"447.91967ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:521 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:36:31.424896Z","caller":"traceutil/trace.go:171","msg":"trace[1010994479] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:545; }","duration":"277.335753ms","start":"2026-03-05T06:36:31.147549Z","end":"2026-03-05T06:36:31.424885Z","steps":["trace[1010994479] 'read index received'  (duration: 184.166019ms)","trace[1010994479] 'applied index is now lower than readState.Index'  (duration: 93.166243ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:36:31.424994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.446966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-05T06:36:31.424981Z","caller":"traceutil/trace.go:171","msg":"trace[870119870] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"448.152755ms","start":"2026-03-05T06:36:30.976801Z","end":"2026-03-05T06:36:31.424953Z","steps":["trace[870119870] 'process raft request'  (duration: 448.024582ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:31.425145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:30.976783Z","time spent":"448.278088ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:36:31.425024Z","caller":"traceutil/trace.go:171","msg":"trace[398930205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:527; }","duration":"277.515587ms","start":"2026-03-05T06:36:31.147499Z","end":"2026-03-05T06:36:31.425015Z","steps":["trace[398930205] 'agreement among raft nodes before linearized reading'  (duration: 277.425535ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:32.587016Z","caller":"traceutil/trace.go:171","msg":"trace[1437393319] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"148.382793ms","start":"2026-03-05T06:36:32.438592Z","end":"2026-03-05T06:36:32.586975Z","steps":["trace[1437393319] 'process raft request'  (duration: 148.157378ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:33.886438Z","caller":"traceutil/trace.go:171","msg":"trace[1607601638] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"454.682392ms","start":"2026-03-05T06:36:33.431731Z","end":"2026-03-05T06:36:33.886413Z","steps":["trace[1607601638] 'process raft request'  (duration: 454.530588ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:33.886598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:33.431704Z","time spent":"454.812505ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:526 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:36:33.88762Z","caller":"traceutil/trace.go:171","msg":"trace[1697749947] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:554; }","duration":"454.367944ms","start":"2026-03-05T06:36:33.433229Z","end":"2026-03-05T06:36:33.887596Z","steps":["trace[1697749947] 'read index received'  (duration: 453.025984ms)","trace[1697749947] 'applied index is now lower than readState.Index'  (duration: 1.340899ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:36:33.887902Z","caller":"traceutil/trace.go:171","msg":"trace[272923489] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"455.10064ms","start":"2026-03-05T06:36:33.432786Z","end":"2026-03-05T06:36:33.887887Z","steps":["trace[272923489] 'process raft request'  (duration: 454.733652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:33.887996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:33.432764Z","time spent":"455.184851ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:527 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T06:36:33.888203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.597089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:36:33.888378Z","caller":"traceutil/trace.go:171","msg":"trace[1034441560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"268.817714ms","start":"2026-03-05T06:36:33.619535Z","end":"2026-03-05T06:36:33.888353Z","steps":["trace[1034441560] 'agreement among raft nodes before linearized reading'  (duration: 268.543958ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:33.888377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.133971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-05T06:36:33.888467Z","caller":"traceutil/trace.go:171","msg":"trace[373397624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:536; }","duration":"455.266263ms","start":"2026-03-05T06:36:33.433184Z","end":"2026-03-05T06:36:33.88845Z","steps":["trace[373397624] 'agreement among raft nodes before linearized reading'  (duration: 454.911885ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:33.888521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:33.433169Z","time spent":"455.342276ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-05T06:36:34.265823Z","caller":"traceutil/trace.go:171","msg":"trace[184738459] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"373.294899ms","start":"2026-03-05T06:36:33.892495Z","end":"2026-03-05T06:36:34.26579Z","steps":["trace[184738459] 'process raft request'  (duration: 304.433375ms)","trace[184738459] 'compare'  (duration: 68.743711ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:36:34.266082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:33.89248Z","time spent":"373.514523ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:528 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-05T06:36:35.948203Z","caller":"traceutil/trace.go:171","msg":"trace[845748137] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"328.913832ms","start":"2026-03-05T06:36:35.619258Z","end":"2026-03-05T06:36:35.948171Z","steps":["trace[845748137] 'read index received'  (duration: 328.007261ms)","trace[845748137] 'applied index is now lower than readState.Index'  (duration: 905.531µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:36:35.948236Z","caller":"traceutil/trace.go:171","msg":"trace[53009188] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"357.479948ms","start":"2026-03-05T06:36:35.590735Z","end":"2026-03-05T06:36:35.948215Z","steps":["trace[53009188] 'process raft request'  (duration: 356.543926ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:35.948683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:35.590719Z","time spent":"357.904946ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<>"}
{"level":"warn","ts":"2026-03-05T06:36:35.948462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.156927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:36:35.948818Z","caller":"traceutil/trace.go:171","msg":"trace[1702454352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"329.582316ms","start":"2026-03-05T06:36:35.619205Z","end":"2026-03-05T06:36:35.948787Z","steps":["trace[1702454352] 'agreement among raft nodes before linearized reading'  (duration: 329.067995ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:35.948931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:35.619188Z","time spent":"329.71289ms","remote":"127.0.0.1:59168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T06:36:39.924404Z","caller":"traceutil/trace.go:171","msg":"trace[1140987878] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"139.977806ms","start":"2026-03-05T06:36:39.7844Z","end":"2026-03-05T06:36:39.924378Z","steps":["trace[1140987878] 'process raft request'  (duration: 139.367903ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:39.980865Z","caller":"traceutil/trace.go:171","msg":"trace[1540067959] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"189.034977ms","start":"2026-03-05T06:36:39.791802Z","end":"2026-03-05T06:36:39.980837Z","steps":["trace[1540067959] 'process raft request'  (duration: 188.403723ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:45.172767Z","caller":"traceutil/trace.go:171","msg":"trace[349820198] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"101.878947ms","start":"2026-03-05T06:36:45.07087Z","end":"2026-03-05T06:36:45.172749Z","steps":["trace[349820198] 'process raft request'  (duration: 101.733574ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:45.212061Z","caller":"traceutil/trace.go:171","msg":"trace[570624867] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"132.453258ms","start":"2026-03-05T06:36:45.079592Z","end":"2026-03-05T06:36:45.212045Z","steps":["trace[570624867] 'process raft request'  (duration: 132.342756ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:45.354252Z","caller":"traceutil/trace.go:171","msg":"trace[1526965483] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"135.587737ms","start":"2026-03-05T06:36:45.218643Z","end":"2026-03-05T06:36:45.354231Z","steps":["trace[1526965483] 'process raft request'  (duration: 69.409055ms)","trace[1526965483] 'compare'  (duration: 66.07469ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:36:45.491772Z","caller":"traceutil/trace.go:171","msg":"trace[321378240] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"133.854108ms","start":"2026-03-05T06:36:45.357892Z","end":"2026-03-05T06:36:45.491746Z","steps":["trace[321378240] 'process raft request'  (duration: 133.771686ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:36:53.402537Z","caller":"traceutil/trace.go:171","msg":"trace[604870708] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"178.718919ms","start":"2026-03-05T06:36:53.223796Z","end":"2026-03-05T06:36:53.402515Z","steps":["trace[604870708] 'process raft request'  (duration: 178.601456ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:53.861015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.367375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:36:53.86121Z","caller":"traceutil/trace.go:171","msg":"trace[1167035615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:718; }","duration":"242.609071ms","start":"2026-03-05T06:36:53.618575Z","end":"2026-03-05T06:36:53.861184Z","steps":["trace[1167035615] 'range keys from in-memory index tree'  (duration: 242.288174ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:55.075914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.351832ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088864834529775 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:713 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:36:55.076002Z","caller":"traceutil/trace.go:171","msg":"trace[1832838949] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:744; }","duration":"1.00179582s","start":"2026-03-05T06:36:54.074191Z","end":"2026-03-05T06:36:55.075986Z","steps":["trace[1832838949] 'read index received'  (duration: 68.173927ms)","trace[1832838949] 'applied index is now lower than readState.Index'  (duration: 933.620503ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:36:55.076069Z","caller":"traceutil/trace.go:171","msg":"trace[2134133687] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"1.009024841s","start":"2026-03-05T06:36:54.067012Z","end":"2026-03-05T06:36:55.076037Z","steps":["trace[2134133687] 'process raft request'  (duration: 506.121466ms)","trace[2134133687] 'compare'  (duration: 502.26104ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:36:55.076147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001963363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T06:36:55.076184Z","caller":"traceutil/trace.go:171","msg":"trace[476459149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:720; }","duration":"1.002021315s","start":"2026-03-05T06:36:54.074154Z","end":"2026-03-05T06:36:55.076175Z","steps":["trace[476459149] 'agreement among raft nodes before linearized reading'  (duration: 1.001896322s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:55.076218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:54.074135Z","time spent":"1.002072866s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-05T06:36:55.076219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:54.066995Z","time spent":"1.009146044s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:713 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:36:55.184536Z","caller":"traceutil/trace.go:171","msg":"trace[1260880626] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"108.483034ms","start":"2026-03-05T06:36:55.076026Z","end":"2026-03-05T06:36:55.184509Z","steps":["trace[1260880626] 'read index received'  (duration: 78.304353ms)","trace[1260880626] 'applied index is now lower than readState.Index'  (duration: 30.174071ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:36:55.184545Z","caller":"traceutil/trace.go:171","msg":"trace[1415272399] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"103.890883ms","start":"2026-03-05T06:36:55.080629Z","end":"2026-03-05T06:36:55.184519Z","steps":["trace[1415272399] 'process raft request'  (duration: 103.76839ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:55.184717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.571326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-05T06:36:55.184704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.727302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:36:55.184749Z","caller":"traceutil/trace.go:171","msg":"trace[250768410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:721; }","duration":"825.644597ms","start":"2026-03-05T06:36:54.359094Z","end":"2026-03-05T06:36:55.184738Z","steps":["trace[250768410] 'agreement among raft nodes before linearized reading'  (duration: 825.495554ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:55.184784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:54.359074Z","time spent":"825.703029ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-05T06:36:55.184787Z","caller":"traceutil/trace.go:171","msg":"trace[1955622288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:721; }","duration":"565.826524ms","start":"2026-03-05T06:36:54.618942Z","end":"2026-03-05T06:36:55.184768Z","steps":["trace[1955622288] 'agreement among raft nodes before linearized reading'  (duration: 565.681621ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:55.184833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:54.618881Z","time spent":"565.944248ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T06:36:56.241774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.713141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:36:56.241827Z","caller":"traceutil/trace.go:171","msg":"trace[2141417152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"622.777753ms","start":"2026-03-05T06:36:55.619037Z","end":"2026-03-05T06:36:56.241815Z","steps":["trace[2141417152] 'range keys from in-memory index tree'  (duration: 622.564627ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:36:56.242013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:36:55.618951Z","time spent":"623.054079ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T06:36:56.473628Z","caller":"traceutil/trace.go:171","msg":"trace[131250929] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"228.6894ms","start":"2026-03-05T06:36:56.244915Z","end":"2026-03-05T06:36:56.473604Z","steps":["trace[131250929] 'process raft request'  (duration: 228.531036ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:17.44996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.64912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T06:37:17.450061Z","caller":"traceutil/trace.go:171","msg":"trace[993708814] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"173.806293ms","start":"2026-03-05T06:37:17.276234Z","end":"2026-03-05T06:37:17.45004Z","steps":["trace[993708814] 'range keys from in-memory index tree'  (duration: 173.482137ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:17.45014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.877834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T06:37:17.450231Z","caller":"traceutil/trace.go:171","msg":"trace[419660361] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"170.046878ms","start":"2026-03-05T06:37:17.280163Z","end":"2026-03-05T06:37:17.45021Z","steps":["trace[419660361] 'range keys from in-memory index tree'  (duration: 169.70187ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:17.559477Z","caller":"traceutil/trace.go:171","msg":"trace[399484501] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"104.585315ms","start":"2026-03-05T06:37:17.454869Z","end":"2026-03-05T06:37:17.559454Z","steps":["trace[399484501] 'process raft request'  (duration: 104.433691ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:17.973249Z","caller":"traceutil/trace.go:171","msg":"trace[1009506356] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"402.107834ms","start":"2026-03-05T06:37:17.571119Z","end":"2026-03-05T06:37:17.973227Z","steps":["trace[1009506356] 'read index received'  (duration: 401.908469ms)","trace[1009506356] 'applied index is now lower than readState.Index'  (duration: 198.025µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:17.973357Z","caller":"traceutil/trace.go:171","msg":"trace[684789981] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"518.2846ms","start":"2026-03-05T06:37:17.455035Z","end":"2026-03-05T06:37:17.973319Z","steps":["trace[684789981] 'process raft request'  (duration: 517.945212ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:17.97352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.38191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T06:37:17.973584Z","caller":"traceutil/trace.go:171","msg":"trace[581403761] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:789; }","duration":"402.576934ms","start":"2026-03-05T06:37:17.570996Z","end":"2026-03-05T06:37:17.973573Z","steps":["trace[581403761] 'agreement among raft nodes before linearized reading'  (duration: 402.37371ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:17.973583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:17.455001Z","time spent":"518.443773ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:784 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-05T06:37:17.973638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:17.570973Z","time spent":"402.638675ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-05T06:37:18.000721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:37:18.000797Z","caller":"traceutil/trace.go:171","msg":"trace[700310093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"381.635092ms","start":"2026-03-05T06:37:17.619144Z","end":"2026-03-05T06:37:18.000779Z","steps":["trace[700310093] 'agreement among raft nodes before linearized reading'  (duration: 381.428028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:18.000838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:17.619125Z","time spent":"381.706304ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T06:37:18.766383Z","caller":"traceutil/trace.go:171","msg":"trace[720314605] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"180.843061ms","start":"2026-03-05T06:37:18.585515Z","end":"2026-03-05T06:37:18.766358Z","steps":["trace[720314605] 'process raft request'  (duration: 180.366301ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:19.361356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.950426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-05T06:37:19.361534Z","caller":"traceutil/trace.go:171","msg":"trace[2116439712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"146.187231ms","start":"2026-03-05T06:37:19.215322Z","end":"2026-03-05T06:37:19.361509Z","steps":["trace[2116439712] 'range keys from in-memory index tree'  (duration: 145.729651ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:19.672829Z","caller":"traceutil/trace.go:171","msg":"trace[598941794] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"104.40291ms","start":"2026-03-05T06:37:19.568399Z","end":"2026-03-05T06:37:19.672802Z","steps":["trace[598941794] 'process raft request'  (duration: 104.023852ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:19.87404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.986808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T06:37:19.874179Z","caller":"traceutil/trace.go:171","msg":"trace[941729016] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:795; }","duration":"110.241863ms","start":"2026-03-05T06:37:19.763912Z","end":"2026-03-05T06:37:19.874154Z","steps":["trace[941729016] 'count revisions from in-memory index tree'  (duration: 109.818013ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:20.2396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.17896ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088864834530009 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:791 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:37:20.239718Z","caller":"traceutil/trace.go:171","msg":"trace[773633363] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"202.673543ms","start":"2026-03-05T06:37:20.037022Z","end":"2026-03-05T06:37:20.239695Z","steps":["trace[773633363] 'process raft request'  (duration: 49.30709ms)","trace[773633363] 'compare'  (duration: 153.037926ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:21.031313Z","caller":"traceutil/trace.go:171","msg":"trace[1530068606] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"254.624364ms","start":"2026-03-05T06:37:20.77666Z","end":"2026-03-05T06:37:21.031284Z","steps":["trace[1530068606] 'process raft request'  (duration: 254.47188ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:21.93309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.127793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T06:37:21.933106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.712738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-05T06:37:21.933171Z","caller":"traceutil/trace.go:171","msg":"trace[1160573741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"314.264616ms","start":"2026-03-05T06:37:21.618887Z","end":"2026-03-05T06:37:21.933152Z","steps":["trace[1160573741] 'range keys from in-memory index tree'  (duration: 314.035541ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:21.933197Z","caller":"traceutil/trace.go:171","msg":"trace[1039128615] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"255.863322ms","start":"2026-03-05T06:37:21.677318Z","end":"2026-03-05T06:37:21.933181Z","steps":["trace[1039128615] 'range keys from in-memory index tree'  (duration: 255.519455ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:21.933219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:21.618865Z","time spent":"314.344747ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T06:37:22.172984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.932593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T06:37:22.173066Z","caller":"traceutil/trace.go:171","msg":"trace[1446723694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"137.070186ms","start":"2026-03-05T06:37:22.035978Z","end":"2026-03-05T06:37:22.173048Z","steps":["trace[1446723694] 'range keys from in-memory index tree'  (duration: 136.759599ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:22.361314Z","caller":"traceutil/trace.go:171","msg":"trace[2051787337] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"109.999238ms","start":"2026-03-05T06:37:22.251291Z","end":"2026-03-05T06:37:22.36129Z","steps":["trace[2051787337] 'read index received'  (duration: 109.863115ms)","trace[2051787337] 'applied index is now lower than readState.Index'  (duration: 134.723µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:22.361408Z","caller":"traceutil/trace.go:171","msg":"trace[67052374] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"184.70986ms","start":"2026-03-05T06:37:22.176671Z","end":"2026-03-05T06:37:22.361381Z","steps":["trace[67052374] 'process raft request'  (duration: 184.466174ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:22.361525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.210402ms","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-05T06:37:22.36156Z","caller":"traceutil/trace.go:171","msg":"trace[1254035537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"110.286394ms","start":"2026-03-05T06:37:22.251264Z","end":"2026-03-05T06:37:22.36155Z","steps":["trace[1254035537] 'agreement among raft nodes before linearized reading'  (duration: 110.123111ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:32.771337Z","caller":"traceutil/trace.go:171","msg":"trace[2117908356] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"135.687926ms","start":"2026-03-05T06:37:32.635624Z","end":"2026-03-05T06:37:32.771312Z","steps":["trace[2117908356] 'process raft request'  (duration: 135.499411ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:32.891445Z","caller":"traceutil/trace.go:171","msg":"trace[519028128] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"101.757261ms","start":"2026-03-05T06:37:32.789668Z","end":"2026-03-05T06:37:32.891426Z","steps":["trace[519028128] 'process raft request'  (duration: 101.715369ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:32.891573Z","caller":"traceutil/trace.go:171","msg":"trace[1814563701] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"104.538974ms","start":"2026-03-05T06:37:32.787004Z","end":"2026-03-05T06:37:32.891543Z","steps":["trace[1814563701] 'process raft request'  (duration: 54.084488ms)","trace[1814563701] 'compare'  (duration: 50.193639ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:33.162225Z","caller":"traceutil/trace.go:171","msg":"trace[58482735] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"102.957629ms","start":"2026-03-05T06:37:33.059244Z","end":"2026-03-05T06:37:33.162202Z","steps":["trace[58482735] 'process raft request'  (duration: 102.838906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:33.162265Z","caller":"traceutil/trace.go:171","msg":"trace[1586056883] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:910; }","duration":"106.352975ms","start":"2026-03-05T06:37:33.055879Z","end":"2026-03-05T06:37:33.162232Z","steps":["trace[1586056883] 'read index received'  (duration: 45.284909ms)","trace[1586056883] 'applied index is now lower than readState.Index'  (duration: 61.064855ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:33.162747Z","caller":"traceutil/trace.go:171","msg":"trace[1879422172] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"110.122289ms","start":"2026-03-05T06:37:33.052586Z","end":"2026-03-05T06:37:33.162709Z","steps":["trace[1879422172] 'process raft request'  (duration: 48.598614ms)","trace[1879422172] 'compare'  (duration: 60.756188ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:37:33.162772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.809785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:11182"}
{"level":"warn","ts":"2026-03-05T06:37:33.162786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.852982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363686"}
{"level":"info","ts":"2026-03-05T06:37:33.162852Z","caller":"traceutil/trace.go:171","msg":"trace[1384844858] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:877; }","duration":"106.977389ms","start":"2026-03-05T06:37:33.055853Z","end":"2026-03-05T06:37:33.162831Z","steps":["trace[1384844858] 'agreement among raft nodes before linearized reading'  (duration: 106.478578ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:33.162908Z","caller":"traceutil/trace.go:171","msg":"trace[310123474] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:877; }","duration":"105.990276ms","start":"2026-03-05T06:37:33.056901Z","end":"2026-03-05T06:37:33.162892Z","steps":["trace[310123474] 'agreement among raft nodes before linearized reading'  (duration: 105.668169ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:33.667085Z","caller":"traceutil/trace.go:171","msg":"trace[1316754551] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:916; }","duration":"119.353007ms","start":"2026-03-05T06:37:33.547705Z","end":"2026-03-05T06:37:33.667058Z","steps":["trace[1316754551] 'read index received'  (duration: 92.861671ms)","trace[1316754551] 'applied index is now lower than readState.Index'  (duration: 26.490386ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:33.667235Z","caller":"traceutil/trace.go:171","msg":"trace[1247505841] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"146.08753ms","start":"2026-03-05T06:37:33.521133Z","end":"2026-03-05T06:37:33.66722Z","steps":["trace[1247505841] 'process raft request'  (duration: 119.44838ms)","trace[1247505841] 'compare'  (duration: 26.341573ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:37:33.667616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.9006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:37:33.667677Z","caller":"traceutil/trace.go:171","msg":"trace[2076255872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:882; }","duration":"119.994071ms","start":"2026-03-05T06:37:33.547667Z","end":"2026-03-05T06:37:33.667661Z","steps":["trace[2076255872] 'agreement among raft nodes before linearized reading'  (duration: 119.854108ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:37.125082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.094476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T06:37:37.125135Z","caller":"traceutil/trace.go:171","msg":"trace[702483501] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:893; }","duration":"216.192577ms","start":"2026-03-05T06:37:36.90893Z","end":"2026-03-05T06:37:37.125123Z","steps":["trace[702483501] 'count revisions from in-memory index tree'  (duration: 215.975373ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:39.000426Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088864834530231,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-05T06:37:39.107244Z","caller":"traceutil/trace.go:171","msg":"trace[332241801] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"606.929575ms","start":"2026-03-05T06:37:38.500292Z","end":"2026-03-05T06:37:39.107221Z","steps":["trace[332241801] 'read index received'  (duration: 606.781112ms)","trace[332241801] 'applied index is now lower than readState.Index'  (duration: 147.303µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:39.107575Z","caller":"traceutil/trace.go:171","msg":"trace[1659825319] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"734.277623ms","start":"2026-03-05T06:37:38.373275Z","end":"2026-03-05T06:37:39.107552Z","steps":["trace[1659825319] 'process raft request'  (duration: 733.801143ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:39.107696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:38.373251Z","time spent":"734.362815ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:817 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-05T06:37:39.107897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.603071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T06:37:39.107928Z","caller":"traceutil/trace.go:171","msg":"trace[1889456003] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:897; }","duration":"607.631852ms","start":"2026-03-05T06:37:38.500287Z","end":"2026-03-05T06:37:39.107919Z","steps":["trace[1889456003] 'agreement among raft nodes before linearized reading'  (duration: 607.54118ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:39.107948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:38.500252Z","time spent":"607.692153ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T06:37:39.108072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.04558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T06:37:39.108099Z","caller":"traceutil/trace.go:171","msg":"trace[331959474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:897; }","duration":"512.113721ms","start":"2026-03-05T06:37:38.595979Z","end":"2026-03-05T06:37:39.108093Z","steps":["trace[331959474] 'agreement among raft nodes before linearized reading'  (duration: 512.05424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:39.108115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:38.595954Z","time spent":"512.157392ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-05T06:37:39.10818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.61491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T06:37:39.108203Z","caller":"traceutil/trace.go:171","msg":"trace[1695255218] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:897; }","duration":"189.669641ms","start":"2026-03-05T06:37:38.918526Z","end":"2026-03-05T06:37:39.108196Z","steps":["trace[1695255218] 'agreement among raft nodes before linearized reading'  (duration: 189.63464ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:39.108307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.956632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:37:39.108331Z","caller":"traceutil/trace.go:171","msg":"trace[1954761135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:897; }","duration":"490.007814ms","start":"2026-03-05T06:37:38.618318Z","end":"2026-03-05T06:37:39.108326Z","steps":["trace[1954761135] 'agreement among raft nodes before linearized reading'  (duration: 489.975193ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:39.108348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:38.618301Z","time spent":"490.042614ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T06:37:39.733311Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088864834530236,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T06:37:40.27936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.522166ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088864834530237 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:893 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:37:40.279493Z","caller":"traceutil/trace.go:171","msg":"trace[218851209] linearizableReadLoop","detail":"{readStateIndex:935; appliedIndex:933; }","duration":"1.047017386s","start":"2026-03-05T06:37:39.232464Z","end":"2026-03-05T06:37:40.279481Z","steps":["trace[218851209] 'read index received'  (duration: 683.400278ms)","trace[218851209] 'applied index is now lower than readState.Index'  (duration: 363.616398ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:40.279674Z","caller":"traceutil/trace.go:171","msg":"trace[237288534] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"1.168170133s","start":"2026-03-05T06:37:39.111495Z","end":"2026-03-05T06:37:40.279665Z","steps":["trace[237288534] 'process raft request'  (duration: 804.277439ms)","trace[237288534] 'compare'  (duration: 363.387433ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:37:40.279727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:39.111473Z","time spent":"1.168229395s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:893 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-05T06:37:40.279878Z","caller":"traceutil/trace.go:171","msg":"trace[85358737] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"1.168218354s","start":"2026-03-05T06:37:39.111652Z","end":"2026-03-05T06:37:40.27987Z","steps":["trace[85358737] 'process raft request'  (duration: 1.167794775s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:40.279923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:39.111644Z","time spent":"1.168257715s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:892 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-05T06:37:40.28006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047603648s","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-05T06:37:40.280086Z","caller":"traceutil/trace.go:171","msg":"trace[110287137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:899; }","duration":"1.04766169s","start":"2026-03-05T06:37:39.232417Z","end":"2026-03-05T06:37:40.280079Z","steps":["trace[110287137] 'agreement among raft nodes before linearized reading'  (duration: 1.047578258s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:40.280105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:39.232401Z","time spent":"1.047700321s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-05T06:37:40.280228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.971116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-05T06:37:40.280253Z","caller":"traceutil/trace.go:171","msg":"trace[10284507] range","detail":"{range_begin:/registry/masterleases/162.253.55.209; range_end:; response_count:1; response_revision:899; }","duration":"917.030938ms","start":"2026-03-05T06:37:39.363216Z","end":"2026-03-05T06:37:40.280247Z","steps":["trace[10284507] 'agreement among raft nodes before linearized reading'  (duration: 916.963536ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:40.28027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:39.363195Z","time spent":"917.071529ms","remote":"127.0.0.1:59214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.209\" "}
{"level":"warn","ts":"2026-03-05T06:37:40.28052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.038136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T06:37:40.280545Z","caller":"traceutil/trace.go:171","msg":"trace[705513433] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:899; }","duration":"129.086736ms","start":"2026-03-05T06:37:40.151453Z","end":"2026-03-05T06:37:40.28054Z","steps":["trace[705513433] 'agreement among raft nodes before linearized reading'  (duration: 129.022755ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:40.280646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.625432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:37:40.280668Z","caller":"traceutil/trace.go:171","msg":"trace[159253654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:899; }","duration":"528.673403ms","start":"2026-03-05T06:37:39.75199Z","end":"2026-03-05T06:37:40.280663Z","steps":["trace[159253654] 'agreement among raft nodes before linearized reading'  (duration: 528.619642ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:40.280685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:39.751977Z","time spent":"528.704054ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-05T06:37:40.280775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.987076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T06:37:40.280832Z","caller":"traceutil/trace.go:171","msg":"trace[525505204] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:899; }","duration":"690.082078ms","start":"2026-03-05T06:37:39.590733Z","end":"2026-03-05T06:37:40.280815Z","steps":["trace[525505204] 'agreement among raft nodes before linearized reading'  (duration: 689.982466ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:40.280872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:39.590714Z","time spent":"690.148669ms","remote":"127.0.0.1:59330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"info","ts":"2026-03-05T06:37:54.685987Z","caller":"traceutil/trace.go:171","msg":"trace[875580685] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"240.465454ms","start":"2026-03-05T06:37:54.445494Z","end":"2026-03-05T06:37:54.68596Z","steps":["trace[875580685] 'process raft request'  (duration: 173.115287ms)","trace[875580685] 'compare'  (duration: 67.183663ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:54.686189Z","caller":"traceutil/trace.go:171","msg":"trace[539665015] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"239.252938ms","start":"2026-03-05T06:37:54.446905Z","end":"2026-03-05T06:37:54.686158Z","steps":["trace[539665015] 'process raft request'  (duration: 239.017092ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:56.801284Z","caller":"traceutil/trace.go:171","msg":"trace[16469887] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"107.460541ms","start":"2026-03-05T06:37:56.693801Z","end":"2026-03-05T06:37:56.801262Z","steps":["trace[16469887] 'process raft request'  (duration: 107.343158ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:56.803248Z","caller":"traceutil/trace.go:171","msg":"trace[642702632] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"108.039622ms","start":"2026-03-05T06:37:56.695187Z","end":"2026-03-05T06:37:56.803227Z","steps":["trace[642702632] 'process raft request'  (duration: 107.876389ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:37:58.646751Z","caller":"traceutil/trace.go:171","msg":"trace[790588533] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"193.6583ms","start":"2026-03-05T06:37:58.453068Z","end":"2026-03-05T06:37:58.646726Z","steps":["trace[790588533] 'read index received'  (duration: 193.466946ms)","trace[790588533] 'applied index is now lower than readState.Index'  (duration: 190.684µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:37:58.646843Z","caller":"traceutil/trace.go:171","msg":"trace[988105125] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"242.979661ms","start":"2026-03-05T06:37:58.403854Z","end":"2026-03-05T06:37:58.646834Z","steps":["trace[988105125] 'process raft request'  (duration: 242.736085ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:58.647054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.975577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T06:37:58.647085Z","caller":"traceutil/trace.go:171","msg":"trace[1198809936] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:968; }","duration":"194.052369ms","start":"2026-03-05T06:37:58.453022Z","end":"2026-03-05T06:37:58.647074Z","steps":["trace[1198809936] 'agreement among raft nodes before linearized reading'  (duration: 193.936856ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:58.647092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.561522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:37:58.647173Z","caller":"traceutil/trace.go:171","msg":"trace[194574562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"155.697905ms","start":"2026-03-05T06:37:58.491456Z","end":"2026-03-05T06:37:58.647153Z","steps":["trace[194574562] 'agreement among raft nodes before linearized reading'  (duration: 155.460409ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:37:58.886687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.540237ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088864834530408 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-jzgvg.1899de995f72e432\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-jzgvg.1899de995f72e432\" value_size:787 lease:4004716827979754352 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:37:58.88685Z","caller":"traceutil/trace.go:171","msg":"trace[30885197] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"218.160392ms","start":"2026-03-05T06:37:58.668669Z","end":"2026-03-05T06:37:58.88683Z","steps":["trace[30885197] 'process raft request'  (duration: 76.4032ms)","trace[30885197] 'compare'  (duration: 141.357823ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:38:01.023599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.591734ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088864834530428 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:926 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:38:01.023704Z","caller":"traceutil/trace.go:171","msg":"trace[1285190649] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"406.513303ms","start":"2026-03-05T06:38:00.617175Z","end":"2026-03-05T06:38:01.023688Z","steps":["trace[1285190649] 'read index received'  (duration: 42.291µs)","trace[1285190649] 'applied index is now lower than readState.Index'  (duration: 406.469622ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:38:01.023844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.655337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:38:01.02382Z","caller":"traceutil/trace.go:171","msg":"trace[401157454] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"1.198064666s","start":"2026-03-05T06:37:59.825726Z","end":"2026-03-05T06:38:01.023791Z","steps":["trace[401157454] 'process raft request'  (duration: 529.179275ms)","trace[401157454] 'compare'  (duration: 668.451411ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:38:01.023882Z","caller":"traceutil/trace.go:171","msg":"trace[1862874016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"406.749869ms","start":"2026-03-05T06:38:00.617121Z","end":"2026-03-05T06:38:01.023871Z","steps":["trace[1862874016] 'agreement among raft nodes before linearized reading'  (duration: 406.665697ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:01.02398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:37:59.825701Z","time spent":"1.198188789s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:926 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-05T06:38:01.024369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.290175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T06:38:01.024475Z","caller":"traceutil/trace.go:171","msg":"trace[1617333389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:981; }","duration":"373.455259ms","start":"2026-03-05T06:38:00.651001Z","end":"2026-03-05T06:38:01.024456Z","steps":["trace[1617333389] 'agreement among raft nodes before linearized reading'  (duration: 373.188413ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:01.024526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:00.650979Z","time spent":"373.53873ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T06:38:01.024538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:00.6171Z","time spent":"406.80738ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T06:38:01.024692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.606796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:38:01.024723Z","caller":"traceutil/trace.go:171","msg":"trace[1446741481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:981; }","duration":"323.675627ms","start":"2026-03-05T06:38:00.701039Z","end":"2026-03-05T06:38:01.024715Z","steps":["trace[1446741481] 'agreement among raft nodes before linearized reading'  (duration: 323.594536ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:01.024747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:00.701019Z","time spent":"323.722458ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-05T06:38:01.025007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.352521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T06:38:01.025161Z","caller":"traceutil/trace.go:171","msg":"trace[384583881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"355.520265ms","start":"2026-03-05T06:38:00.669622Z","end":"2026-03-05T06:38:01.025143Z","steps":["trace[384583881] 'agreement among raft nodes before linearized reading'  (duration: 355.142687ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:01.025272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:00.669558Z","time spent":"355.701219ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-05T06:38:02.119546Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088864834530431,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T06:38:02.133261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.479996ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088864834530432 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:972 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:38:02.133331Z","caller":"traceutil/trace.go:171","msg":"trace[1128173645] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"1.104538651s","start":"2026-03-05T06:38:01.028775Z","end":"2026-03-05T06:38:02.133313Z","steps":["trace[1128173645] 'process raft request'  (duration: 310.932492ms)","trace[1128173645] 'compare'  (duration: 793.391694ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:38:02.133401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:01.028753Z","time spent":"1.104608772s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:972 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:38:02.190475Z","caller":"traceutil/trace.go:171","msg":"trace[497531429] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1023; }","duration":"571.54552ms","start":"2026-03-05T06:38:01.618891Z","end":"2026-03-05T06:38:02.190436Z","steps":["trace[497531429] 'read index received'  (duration: 571.390366ms)","trace[497531429] 'applied index is now lower than readState.Index'  (duration: 154.324µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:38:02.190572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.669792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:38:02.190595Z","caller":"traceutil/trace.go:171","msg":"trace[1605925927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:986; }","duration":"571.749194ms","start":"2026-03-05T06:38:01.618838Z","end":"2026-03-05T06:38:02.190587Z","steps":["trace[1605925927] 'agreement among raft nodes before linearized reading'  (duration: 571.690053ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:38:02.190587Z","caller":"traceutil/trace.go:171","msg":"trace[535357018] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.160000339s","start":"2026-03-05T06:38:01.030504Z","end":"2026-03-05T06:38:02.190504Z","steps":["trace[535357018] 'process raft request'  (duration: 1.159890997s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:02.190616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:01.618819Z","time spent":"571.792095ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T06:38:02.190783Z","caller":"traceutil/trace.go:171","msg":"trace[482448890] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"1.160276946s","start":"2026-03-05T06:38:01.03049Z","end":"2026-03-05T06:38:02.190767Z","steps":["trace[482448890] 'process raft request'  (duration: 1.159923018s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:02.190797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:01.030495Z","time spent":"1.160179923s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:973 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-05T06:38:02.190862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:01.030473Z","time spent":"1.160332737s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:969 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-05T06:38:02.190901Z","caller":"traceutil/trace.go:171","msg":"trace[128328916] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"1.161837591s","start":"2026-03-05T06:38:01.02904Z","end":"2026-03-05T06:38:02.190878Z","steps":["trace[128328916] 'process raft request'  (duration: 1.161215357s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:02.191005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:01.02902Z","time spent":"1.161928652s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:968 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-05T06:38:02.192924Z","caller":"traceutil/trace.go:171","msg":"trace[1231306916] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"1.16088992s","start":"2026-03-05T06:38:01.029583Z","end":"2026-03-05T06:38:02.190473Z","steps":["trace[1231306916] 'process raft request'  (duration: 1.160789227s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:38:02.193087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:38:01.029568Z","time spent":"1.163433007s","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:970 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:38:03.992782Z","caller":"traceutil/trace.go:171","msg":"trace[1002069975] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"212.889927ms","start":"2026-03-05T06:38:03.779869Z","end":"2026-03-05T06:38:03.992759Z","steps":["trace[1002069975] 'process raft request'  (duration: 200.888566ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:40:59.526204Z","caller":"traceutil/trace.go:171","msg":"trace[1822048272] transaction","detail":"{read_only:false; response_revision:1740; number_of_response:1; }","duration":"129.379921ms","start":"2026-03-05T06:40:59.396791Z","end":"2026-03-05T06:40:59.526171Z","steps":["trace[1822048272] 'process raft request'  (duration: 129.117866ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:40:59.526408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.497065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-05T06:40:59.526472Z","caller":"traceutil/trace.go:171","msg":"trace[135432222] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1740; }","duration":"129.614387ms","start":"2026-03-05T06:40:59.396847Z","end":"2026-03-05T06:40:59.526461Z","steps":["trace[135432222] 'agreement among raft nodes before linearized reading'  (duration: 129.482674ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:40:59.526241Z","caller":"traceutil/trace.go:171","msg":"trace[1005284948] linearizableReadLoop","detail":"{readStateIndex:1818; appliedIndex:1817; }","duration":"129.163937ms","start":"2026-03-05T06:40:59.396886Z","end":"2026-03-05T06:40:59.52605Z","steps":["trace[1005284948] 'read index received'  (duration: 129.018964ms)","trace[1005284948] 'applied index is now lower than readState.Index'  (duration: 143.643µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:40:59.535455Z","caller":"traceutil/trace.go:171","msg":"trace[423642749] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"133.977315ms","start":"2026-03-05T06:40:59.401454Z","end":"2026-03-05T06:40:59.535432Z","steps":["trace[423642749] 'process raft request'  (duration: 133.939894ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:40:59.535763Z","caller":"traceutil/trace.go:171","msg":"trace[695779007] transaction","detail":"{read_only:false; response_revision:1741; number_of_response:1; }","duration":"134.371214ms","start":"2026-03-05T06:40:59.401374Z","end":"2026-03-05T06:40:59.535745Z","steps":["trace[695779007] 'process raft request'  (duration: 133.935014ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:41:19.824965Z","caller":"traceutil/trace.go:171","msg":"trace[1972291831] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"206.48438ms","start":"2026-03-05T06:41:19.618456Z","end":"2026-03-05T06:41:19.82494Z","steps":["trace[1972291831] 'read index received'  (duration: 203.240807ms)","trace[1972291831] 'applied index is now lower than readState.Index'  (duration: 3.242463ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:41:19.825002Z","caller":"traceutil/trace.go:171","msg":"trace[531341488] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"397.109447ms","start":"2026-03-05T06:41:19.427861Z","end":"2026-03-05T06:41:19.824971Z","steps":["trace[531341488] 'process raft request'  (duration: 393.899134ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:41:19.825158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.675865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T06:41:19.825158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:41:19.427846Z","time spent":"397.23192ms","remote":"127.0.0.1:59214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.209\" mod_revision:1796 > success:<request_put:<key:\"/registry/masterleases/162.253.55.209\" value_size:67 lease:4004716827979756784 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.209\" > >"}
{"level":"info","ts":"2026-03-05T06:41:19.825197Z","caller":"traceutil/trace.go:171","msg":"trace[1624779873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1843; }","duration":"206.772637ms","start":"2026-03-05T06:41:19.618412Z","end":"2026-03-05T06:41:19.825184Z","steps":["trace[1624779873] 'agreement among raft nodes before linearized reading'  (duration: 206.665695ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:41:19.825552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.547556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-05T06:41:19.825618Z","caller":"traceutil/trace.go:171","msg":"trace[521344835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1843; }","duration":"174.643269ms","start":"2026-03-05T06:41:19.650962Z","end":"2026-03-05T06:41:19.825605Z","steps":["trace[521344835] 'agreement among raft nodes before linearized reading'  (duration: 174.488495ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:41:20.043498Z","caller":"traceutil/trace.go:171","msg":"trace[247743996] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1925; }","duration":"207.464953ms","start":"2026-03-05T06:41:19.83601Z","end":"2026-03-05T06:41:20.043475Z","steps":["trace[247743996] 'read index received'  (duration: 88.976651ms)","trace[247743996] 'applied index is now lower than readState.Index'  (duration: 118.487412ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:41:20.043554Z","caller":"traceutil/trace.go:171","msg":"trace[272969602] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"208.160148ms","start":"2026-03-05T06:41:19.83537Z","end":"2026-03-05T06:41:20.04353Z","steps":["trace[272969602] 'process raft request'  (duration: 208.027475ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:41:20.043697Z","caller":"traceutil/trace.go:171","msg":"trace[2004181350] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"212.127488ms","start":"2026-03-05T06:41:19.83156Z","end":"2026-03-05T06:41:20.043687Z","steps":["trace[2004181350] 'process raft request'  (duration: 176.270445ms)","trace[2004181350] 'compare'  (duration: 35.452193ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:41:20.043669Z","caller":"traceutil/trace.go:171","msg":"trace[2120643366] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"206.940901ms","start":"2026-03-05T06:41:19.836715Z","end":"2026-03-05T06:41:20.043656Z","steps":["trace[2120643366] 'process raft request'  (duration: 206.725765ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:41:20.04382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.386079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:41:20.043875Z","caller":"traceutil/trace.go:171","msg":"trace[133428986] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1847; }","duration":"185.461772ms","start":"2026-03-05T06:41:19.858401Z","end":"2026-03-05T06:41:20.043863Z","steps":["trace[133428986] 'agreement among raft nodes before linearized reading'  (duration: 185.37754ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:41:20.04389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.840121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-05T06:41:20.043968Z","caller":"traceutil/trace.go:171","msg":"trace[847657890] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1847; }","duration":"207.970875ms","start":"2026-03-05T06:41:19.835985Z","end":"2026-03-05T06:41:20.043956Z","steps":["trace[847657890] 'agreement among raft nodes before linearized reading'  (duration: 207.807811ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:41:20.043905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.235379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"warn","ts":"2026-03-05T06:41:20.044037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.58646ms","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-05T06:41:20.044091Z","caller":"traceutil/trace.go:171","msg":"trace[256773402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1847; }","duration":"133.688632ms","start":"2026-03-05T06:41:19.910389Z","end":"2026-03-05T06:41:20.044077Z","steps":["trace[256773402] 'agreement among raft nodes before linearized reading'  (duration: 133.523668ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:41:20.044049Z","caller":"traceutil/trace.go:171","msg":"trace[264570060] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1847; }","duration":"111.412424ms","start":"2026-03-05T06:41:19.932627Z","end":"2026-03-05T06:41:20.044039Z","steps":["trace[264570060] 'agreement among raft nodes before linearized reading'  (duration: 111.158048ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:41:20.044683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.757273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-05T06:41:20.044762Z","caller":"traceutil/trace.go:171","msg":"trace[1580031478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1847; }","duration":"133.869366ms","start":"2026-03-05T06:41:19.910878Z","end":"2026-03-05T06:41:20.044747Z","steps":["trace[1580031478] 'agreement among raft nodes before linearized reading'  (duration: 132.945226ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:41:20.160148Z","caller":"traceutil/trace.go:171","msg":"trace[1765318247] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1929; }","duration":"111.389163ms","start":"2026-03-05T06:41:20.048744Z","end":"2026-03-05T06:41:20.160133Z","steps":["trace[1765318247] 'read index received'  (duration: 29.89184ms)","trace[1765318247] 'applied index is now lower than readState.Index'  (duration: 81.496663ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:41:20.160249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.487885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:41:20.160475Z","caller":"traceutil/trace.go:171","msg":"trace[918218405] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"112.004217ms","start":"2026-03-05T06:41:20.048159Z","end":"2026-03-05T06:41:20.160163Z","steps":["trace[918218405] 'process raft request'  (duration: 97.812459ms)","trace[918218405] 'compare'  (duration: 14.070665ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:41:20.160554Z","caller":"traceutil/trace.go:171","msg":"trace[1074936778] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1850; }","duration":"111.533426ms","start":"2026-03-05T06:41:20.048729Z","end":"2026-03-05T06:41:20.160262Z","steps":["trace[1074936778] 'agreement among raft nodes before linearized reading'  (duration: 111.468654ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:41:20.160617Z","caller":"traceutil/trace.go:171","msg":"trace[1895871297] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"111.867763ms","start":"2026-03-05T06:41:20.048402Z","end":"2026-03-05T06:41:20.160269Z","steps":["trace[1895871297] 'process raft request'  (duration: 111.70642ms)"],"step_count":1}