{"level":"warn","ts":"2026-02-10T18:51:18.34728Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-10T18:51:18.348063Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-02-10T18:51:18.348147Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-10T18:51:18.348168Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]}
{"level":"info","ts":"2026-02-10T18:51:18.3482Z","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-02-10T18:51:18.349711Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]}
{"level":"info","ts":"2026-02-10T18:51:18.35143Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-02-10T18:51:18.358294Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.431847ms"}
{"level":"info","ts":"2026-02-10T18:51:18.379136Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"}
{"level":"info","ts":"2026-02-10T18:51:18.379202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"}
{"level":"info","ts":"2026-02-10T18:51:18.379223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"}
{"level":"info","ts":"2026-02-10T18:51:18.37923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-10T18:51:18.379238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"}
{"level":"info","ts":"2026-02-10T18:51:18.37927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"}
{"level":"warn","ts":"2026-02-10T18:51:18.396808Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-10T18:51:18.405248Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-10T18:51:18.414351Z","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-02-10T18:51:18.417682Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-10T18:51:18.426926Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-10T18:51:18.427073Z","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-02-10T18:51:18.427093Z","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-02-10T18:51:18.427099Z","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-02-10T18:51:18.427753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"}
{"level":"info","ts":"2026-02-10T18:51:18.42783Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]}
{"level":"info","ts":"2026-02-10T18:51:18.428029Z","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-02-10T18:51:18.428119Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"}
{"level":"info","ts":"2026-02-10T18:51:18.428126Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"}
{"level":"info","ts":"2026-02-10T18:51:18.434494Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-10T18:51:18.434532Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-10T18:51:18.679882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"}
{"level":"info","ts":"2026-02-10T18:51:18.679961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-10T18:51:18.67999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"}
{"level":"info","ts":"2026-02-10T18:51:18.680011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"}
{"level":"info","ts":"2026-02-10T18:51:18.680029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"}
{"level":"info","ts":"2026-02-10T18:51:18.680053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"}
{"level":"info","ts":"2026-02-10T18:51:18.680071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"}
{"level":"info","ts":"2026-02-10T18:51:18.682153Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-10T18:51:18.682193Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-10T18:51:18.682595Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-10T18:51:18.682244Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T18:51:18.68278Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-10T18:51:18.682809Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-10T18:51:18.684038Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-10T18:51:18.68636Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T18:51:18.686431Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T18:51:18.686464Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T18:51:18.701745Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"}
{"level":"info","ts":"2026-02-10T18:51:22.573185Z","caller":"traceutil/trace.go:171","msg":"trace[5266069] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"105.817102ms","start":"2026-02-10T18:51:22.467305Z","end":"2026-02-10T18:51:22.573123Z","steps":["trace[5266069] 'process raft request'  (duration: 60.839699ms)","trace[5266069] 'compare'  (duration: 44.860101ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:51:23.783451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813192437,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T18:51:24.283966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813192437,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T18:51:24.784655Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813192437,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T18:51:25.168988Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.03472636s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-10T18:51:25.169285Z","caller":"traceutil/trace.go:171","msg":"trace[1933071768] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"2.035100588s","start":"2026-02-10T18:51:23.134169Z","end":"2026-02-10T18:51:25.169269Z","steps":["trace[1933071768] 'process raft request'  (duration: 2.035010606s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.169731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:23.13415Z","time spent":"2.035189391s","remote":"127.0.0.1:51040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3383,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:28 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3349 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-10T18:51:25.348511Z","caller":"traceutil/trace.go:171","msg":"trace[460950389] linearizableReadLoop","detail":"{readStateIndex:217; appliedIndex:215; }","duration":"2.065471979s","start":"2026-02-10T18:51:23.283017Z","end":"2026-02-10T18:51:25.348489Z","steps":["trace[460950389] 'read index received'  (duration: 1.886991405s)","trace[460950389] 'applied index is now lower than readState.Index'  (duration: 178.479374ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:25.348632Z","caller":"traceutil/trace.go:171","msg":"trace[2129761404] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"1.24629585s","start":"2026-02-10T18:51:24.102325Z","end":"2026-02-10T18:51:25.348621Z","steps":["trace[2129761404] 'process raft request'  (duration: 1.238085291s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.348739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:24.102301Z","time spent":"1.246374372s","remote":"127.0.0.1:51046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2883,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2825 >> failure:<>"}
{"level":"info","ts":"2026-02-10T18:51:25.348861Z","caller":"traceutil/trace.go:171","msg":"trace[1246084113] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"1.161869209s","start":"2026-02-10T18:51:24.186983Z","end":"2026-02-10T18:51:25.348852Z","steps":["trace[1246084113] 'process raft request'  (duration: 1.161401478s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.348907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:24.186963Z","time spent":"1.161923881s","remote":"127.0.0.1:51046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5409 >> failure:<>"}
{"level":"warn","ts":"2026-02-10T18:51:25.348991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:24.918508Z","time spent":"430.482106ms","remote":"127.0.0.1:50942","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-10T18:51:25.349209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.066197905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:51:25.349286Z","caller":"traceutil/trace.go:171","msg":"trace[962835531] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:212; }","duration":"2.066302607s","start":"2026-02-10T18:51:23.282946Z","end":"2026-02-10T18:51:25.349249Z","steps":["trace[962835531] 'agreement among raft nodes before linearized reading'  (duration: 2.066225405s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.349322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:23.282926Z","time spent":"2.06638864s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-10T18:51:25.349508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.118101ms","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-02-10T18:51:25.349544Z","caller":"traceutil/trace.go:171","msg":"trace[20205958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:212; }","duration":"675.193832ms","start":"2026-02-10T18:51:24.674341Z","end":"2026-02-10T18:51:25.349535Z","steps":["trace[20205958] 'agreement among raft nodes before linearized reading'  (duration: 675.13401ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.34957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:24.674325Z","time spent":"675.239333ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T18:51:25.349806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.71144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-2youcy\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:51:25.349857Z","caller":"traceutil/trace.go:171","msg":"trace[1403031818] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-2youcy; range_end:; response_count:0; response_revision:212; }","duration":"175.784012ms","start":"2026-02-10T18:51:25.174063Z","end":"2026-02-10T18:51:25.349847Z","steps":["trace[1403031818] 'agreement among raft nodes before linearized reading'  (duration: 175.72021ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.349997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.441013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:51:25.350035Z","caller":"traceutil/trace.go:171","msg":"trace[1797889283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:212; }","duration":"379.498695ms","start":"2026-02-10T18:51:24.970523Z","end":"2026-02-10T18:51:25.350022Z","steps":["trace[1797889283] 'agreement among raft nodes before linearized reading'  (duration: 379.452524ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.350059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:24.970511Z","time spent":"379.542396ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-10T18:51:25.350184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.046319ms","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-02-10T18:51:25.350218Z","caller":"traceutil/trace.go:171","msg":"trace[1457093702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:212; }","duration":"645.09666ms","start":"2026-02-10T18:51:24.705111Z","end":"2026-02-10T18:51:25.350208Z","steps":["trace[1457093702] 'agreement among raft nodes before linearized reading'  (duration: 645.046519ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:25.350247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:24.705102Z","time spent":"645.140161ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-10T18:51:30.434368Z","caller":"traceutil/trace.go:171","msg":"trace[1388895931] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"114.452731ms","start":"2026-02-10T18:51:30.319896Z","end":"2026-02-10T18:51:30.434348Z","steps":["trace[1388895931] 'process raft request'  (duration: 45.020695ms)","trace[1388895931] 'compare'  (duration: 69.288272ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:30.591069Z","caller":"traceutil/trace.go:171","msg":"trace[1980108071] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:366; }","duration":"128.880383ms","start":"2026-02-10T18:51:30.462169Z","end":"2026-02-10T18:51:30.59105Z","steps":["trace[1980108071] 'read index received'  (duration: 47.806029ms)","trace[1980108071] 'applied index is now lower than readState.Index'  (duration: 81.073444ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:30.591554Z","caller":"traceutil/trace.go:171","msg":"trace[899659326] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"137.8928ms","start":"2026-02-10T18:51:30.453648Z","end":"2026-02-10T18:51:30.591541Z","steps":["trace[899659326] 'process raft request'  (duration: 136.963209ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.592534Z","caller":"traceutil/trace.go:171","msg":"trace[2087365663] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"138.817852ms","start":"2026-02-10T18:51:30.453702Z","end":"2026-02-10T18:51:30.59252Z","steps":["trace[2087365663] 'process raft request'  (duration: 137.259656ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.593151Z","caller":"traceutil/trace.go:171","msg":"trace[1628324829] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"138.847122ms","start":"2026-02-10T18:51:30.454288Z","end":"2026-02-10T18:51:30.593136Z","steps":["trace[1628324829] 'process raft request'  (duration: 136.730223ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:30.593582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.404801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-02-10T18:51:30.593897Z","caller":"traceutil/trace.go:171","msg":"trace[1995602050] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:359; }","duration":"131.486293ms","start":"2026-02-10T18:51:30.46213Z","end":"2026-02-10T18:51:30.593617Z","steps":["trace[1995602050] 'agreement among raft nodes before linearized reading'  (duration: 131.398451ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.623596Z","caller":"traceutil/trace.go:171","msg":"trace[500472671] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"109.640091ms","start":"2026-02-10T18:51:30.513943Z","end":"2026-02-10T18:51:30.623583Z","steps":["trace[500472671] 'process raft request'  (duration: 109.574989ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:30.624076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.248317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"}
{"level":"info","ts":"2026-02-10T18:51:30.624122Z","caller":"traceutil/trace.go:171","msg":"trace[1395909630] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:360; }","duration":"111.350689ms","start":"2026-02-10T18:51:30.512745Z","end":"2026-02-10T18:51:30.624095Z","steps":["trace[1395909630] 'agreement among raft nodes before linearized reading'  (duration: 111.238617ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:30.624221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.522003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-10T18:51:30.624238Z","caller":"traceutil/trace.go:171","msg":"trace[292586886] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:360; }","duration":"111.558755ms","start":"2026-02-10T18:51:30.512674Z","end":"2026-02-10T18:51:30.624233Z","steps":["trace[292586886] 'agreement among raft nodes before linearized reading'  (duration: 111.525324ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.78034Z","caller":"traceutil/trace.go:171","msg":"trace[1713127269] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"103.693674ms","start":"2026-02-10T18:51:30.676628Z","end":"2026-02-10T18:51:30.780322Z","steps":["trace[1713127269] 'process raft request'  (duration: 76.017908ms)","trace[1713127269] 'compare'  (duration: 27.306007ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:30.780509Z","caller":"traceutil/trace.go:171","msg":"trace[520960119] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"103.023108ms","start":"2026-02-10T18:51:30.677481Z","end":"2026-02-10T18:51:30.780504Z","steps":["trace[520960119] 'process raft request'  (duration: 102.566637ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.780703Z","caller":"traceutil/trace.go:171","msg":"trace[727104817] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"102.470375ms","start":"2026-02-10T18:51:30.678227Z","end":"2026-02-10T18:51:30.780698Z","steps":["trace[727104817] 'process raft request'  (duration: 102.017005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.780806Z","caller":"traceutil/trace.go:171","msg":"trace[963261465] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"102.531707ms","start":"2026-02-10T18:51:30.678269Z","end":"2026-02-10T18:51:30.7808Z","steps":["trace[963261465] 'process raft request'  (duration: 101.999335ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.78064Z","caller":"traceutil/trace.go:171","msg":"trace[228559430] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:377; }","duration":"103.885708ms","start":"2026-02-10T18:51:30.676746Z","end":"2026-02-10T18:51:30.780632Z","steps":["trace[228559430] 'read index received'  (duration: 10.45449ms)","trace[228559430] 'applied index is now lower than readState.Index'  (duration: 93.429448ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:51:30.780959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.183195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-10T18:51:30.780978Z","caller":"traceutil/trace.go:171","msg":"trace[1084086975] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:374; }","duration":"104.244837ms","start":"2026-02-10T18:51:30.676728Z","end":"2026-02-10T18:51:30.780973Z","steps":["trace[1084086975] 'agreement among raft nodes before linearized reading'  (duration: 104.171135ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:30.795432Z","caller":"traceutil/trace.go:171","msg":"trace[1070885707] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"100.469389ms","start":"2026-02-10T18:51:30.694953Z","end":"2026-02-10T18:51:30.795423Z","steps":["trace[1070885707] 'process raft request'  (duration: 100.412598ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:31.01058Z","caller":"traceutil/trace.go:171","msg":"trace[2055315982] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"141.530322ms","start":"2026-02-10T18:51:30.869023Z","end":"2026-02-10T18:51:31.010554Z","steps":["trace[2055315982] 'process raft request'  (duration: 58.963525ms)","trace[2055315982] 'compare'  (duration: 82.465155ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:31.01647Z","caller":"traceutil/trace.go:171","msg":"trace[188304108] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"145.550665ms","start":"2026-02-10T18:51:30.870902Z","end":"2026-02-10T18:51:31.016453Z","steps":["trace[188304108] 'process raft request'  (duration: 145.453693ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:31.016635Z","caller":"traceutil/trace.go:171","msg":"trace[1153462701] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"145.665617ms","start":"2026-02-10T18:51:30.870958Z","end":"2026-02-10T18:51:31.016624Z","steps":["trace[1153462701] 'process raft request'  (duration: 145.450072ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:31.016731Z","caller":"traceutil/trace.go:171","msg":"trace[1243123200] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"130.748804ms","start":"2026-02-10T18:51:30.885975Z","end":"2026-02-10T18:51:31.016724Z","steps":["trace[1243123200] 'process raft request'  (duration: 130.479148ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:31.01675Z","caller":"traceutil/trace.go:171","msg":"trace[315506122] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"145.664258ms","start":"2026-02-10T18:51:30.871079Z","end":"2026-02-10T18:51:31.016744Z","steps":["trace[315506122] 'process raft request'  (duration: 145.351421ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:35.118544Z","caller":"traceutil/trace.go:171","msg":"trace[497209639] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"117.214165ms","start":"2026-02-10T18:51:35.001306Z","end":"2026-02-10T18:51:35.11852Z","steps":["trace[497209639] 'process raft request'  (duration: 116.663662ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:37.826061Z","caller":"traceutil/trace.go:171","msg":"trace[712792862] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"143.051038ms","start":"2026-02-10T18:51:37.682985Z","end":"2026-02-10T18:51:37.826037Z","steps":["trace[712792862] 'process raft request'  (duration: 103.720204ms)","trace[712792862] 'compare'  (duration: 38.788142ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:37.83009Z","caller":"traceutil/trace.go:171","msg":"trace[401956221] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"145.014344ms","start":"2026-02-10T18:51:37.685057Z","end":"2026-02-10T18:51:37.830072Z","steps":["trace[401956221] 'process raft request'  (duration: 141.442852ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:37.832954Z","caller":"traceutil/trace.go:171","msg":"trace[503866915] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"147.696495ms","start":"2026-02-10T18:51:37.685241Z","end":"2026-02-10T18:51:37.832938Z","steps":["trace[503866915] 'process raft request'  (duration: 144.800118ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:37.833372Z","caller":"traceutil/trace.go:171","msg":"trace[164994735] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"148.024323ms","start":"2026-02-10T18:51:37.68532Z","end":"2026-02-10T18:51:37.833344Z","steps":["trace[164994735] 'process raft request'  (duration: 145.194528ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:37.833737Z","caller":"traceutil/trace.go:171","msg":"trace[1010126093] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"148.272059ms","start":"2026-02-10T18:51:37.685454Z","end":"2026-02-10T18:51:37.833726Z","steps":["trace[1010126093] 'process raft request'  (duration: 147.850809ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:37.853256Z","caller":"traceutil/trace.go:171","msg":"trace[140335797] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"106.738764ms","start":"2026-02-10T18:51:37.746505Z","end":"2026-02-10T18:51:37.853244Z","steps":["trace[140335797] 'process raft request'  (duration: 106.665332ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:49.893535Z","caller":"traceutil/trace.go:171","msg":"trace[1709139136] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"106.525649ms","start":"2026-02-10T18:51:49.786995Z","end":"2026-02-10T18:51:49.893521Z","steps":["trace[1709139136] 'process raft request'  (duration: 106.503509ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:49.893672Z","caller":"traceutil/trace.go:171","msg":"trace[1836717040] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"107.45349ms","start":"2026-02-10T18:51:49.786214Z","end":"2026-02-10T18:51:49.893667Z","steps":["trace[1836717040] 'process raft request'  (duration: 107.195735ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:51.674826Z","caller":"traceutil/trace.go:171","msg":"trace[307361304] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"944.903801ms","start":"2026-02-10T18:51:50.729899Z","end":"2026-02-10T18:51:51.674803Z","steps":["trace[307361304] 'process raft request'  (duration: 944.773227ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:51.67497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:50.729881Z","time spent":"945.022394ms","remote":"127.0.0.1:51040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4254,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:421 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4220 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-10T18:51:51.692782Z","caller":"traceutil/trace.go:171","msg":"trace[1468124401] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"339.3021ms","start":"2026-02-10T18:51:51.353464Z","end":"2026-02-10T18:51:51.692766Z","steps":["trace[1468124401] 'process raft request'  (duration: 339.003753ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:51.693442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:51.35344Z","time spent":"339.956115ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:461 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-10T18:51:54.095966Z","caller":"traceutil/trace.go:171","msg":"trace[443213943] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"297.57749ms","start":"2026-02-10T18:51:53.79837Z","end":"2026-02-10T18:51:54.095948Z","steps":["trace[443213943] 'read index received'  (duration: 297.455818ms)","trace[443213943] 'applied index is now lower than readState.Index'  (duration: 121.042µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:54.096053Z","caller":"traceutil/trace.go:171","msg":"trace[1740700589] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"387.680242ms","start":"2026-02-10T18:51:53.708364Z","end":"2026-02-10T18:51:54.096044Z","steps":["trace[1740700589] 'process raft request'  (duration: 387.504518ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:54.096118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:51:53.708345Z","time spent":"387.723633ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:520 > 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":"warn","ts":"2026-02-10T18:51:54.096294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.652266ms","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-02-10T18:51:54.096336Z","caller":"traceutil/trace.go:171","msg":"trace[235482998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:525; }","duration":"191.722567ms","start":"2026-02-10T18:51:53.904602Z","end":"2026-02-10T18:51:54.096325Z","steps":["trace[235482998] 'agreement among raft nodes before linearized reading'  (duration: 191.610454ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:54.096378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.00621ms","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-02-10T18:51:54.096398Z","caller":"traceutil/trace.go:171","msg":"trace[1504074600] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:525; }","duration":"298.051322ms","start":"2026-02-10T18:51:53.798341Z","end":"2026-02-10T18:51:54.096392Z","steps":["trace[1504074600] 'agreement among raft nodes before linearized reading'  (duration: 297.97736ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:54.096453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.783589ms","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-02-10T18:51:54.096468Z","caller":"traceutil/trace.go:171","msg":"trace[2026212434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:525; }","duration":"191.804359ms","start":"2026-02-10T18:51:53.904659Z","end":"2026-02-10T18:51:54.096463Z","steps":["trace[2026212434] 'agreement among raft nodes before linearized reading'  (duration: 191.765568ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:51:54.379712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.75687ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193061 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:523 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T18:51:54.379991Z","caller":"traceutil/trace.go:171","msg":"trace[1571615122] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"279.175988ms","start":"2026-02-10T18:51:54.100799Z","end":"2026-02-10T18:51:54.379975Z","steps":["trace[1571615122] 'process raft request'  (duration: 279.003924ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:51:54.380333Z","caller":"traceutil/trace.go:171","msg":"trace[1705969523] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"280.194402ms","start":"2026-02-10T18:51:54.100128Z","end":"2026-02-10T18:51:54.380322Z","steps":["trace[1705969523] 'process raft request'  (duration: 36.629753ms)","trace[1705969523] 'compare'  (duration: 242.651428ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:51:59.75228Z","caller":"traceutil/trace.go:171","msg":"trace[1096786889] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"142.666819ms","start":"2026-02-10T18:51:59.609587Z","end":"2026-02-10T18:51:59.752254Z","steps":["trace[1096786889] 'process raft request'  (duration: 142.418854ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:02.252848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.709441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-10T18:52:02.252929Z","caller":"traceutil/trace.go:171","msg":"trace[997064121] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:555; }","duration":"249.833833ms","start":"2026-02-10T18:52:02.003073Z","end":"2026-02-10T18:52:02.252907Z","steps":["trace[997064121] 'range keys from in-memory index tree'  (duration: 249.379943ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:02.252919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.659259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:02.252993Z","caller":"traceutil/trace.go:171","msg":"trace[1723601772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"212.750311ms","start":"2026-02-10T18:52:02.04022Z","end":"2026-02-10T18:52:02.252971Z","steps":["trace[1723601772] 'range keys from in-memory index tree'  (duration: 212.594617ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:02.384904Z","caller":"traceutil/trace.go:171","msg":"trace[402009103] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"298.360689ms","start":"2026-02-10T18:52:02.08652Z","end":"2026-02-10T18:52:02.384881Z","steps":["trace[402009103] 'process raft request'  (duration: 298.237686ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:02.385835Z","caller":"traceutil/trace.go:171","msg":"trace[1542935994] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:573; }","duration":"298.237586ms","start":"2026-02-10T18:52:02.087564Z","end":"2026-02-10T18:52:02.385801Z","steps":["trace[1542935994] 'read index received'  (duration: 298.214295ms)","trace[1542935994] 'applied index is now lower than readState.Index'  (duration: 8.641µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:02.38601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.42257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-10T18:52:02.386043Z","caller":"traceutil/trace.go:171","msg":"trace[284413398] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:556; }","duration":"298.490982ms","start":"2026-02-10T18:52:02.087542Z","end":"2026-02-10T18:52:02.386032Z","steps":["trace[284413398] 'agreement among raft nodes before linearized reading'  (duration: 298.38477ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:02.401414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.837996ms","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-02-10T18:52:02.402053Z","caller":"traceutil/trace.go:171","msg":"trace[110295768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"281.504781ms","start":"2026-02-10T18:52:02.120537Z","end":"2026-02-10T18:52:02.402042Z","steps":["trace[110295768] 'agreement among raft nodes before linearized reading'  (duration: 280.764024ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:02.401542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.657501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:02.402429Z","caller":"traceutil/trace.go:171","msg":"trace[388791970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"147.584753ms","start":"2026-02-10T18:52:02.254799Z","end":"2026-02-10T18:52:02.402383Z","steps":["trace[388791970] 'agreement among raft nodes before linearized reading'  (duration: 146.688272ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:02.401667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.542216ms","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-02-10T18:52:02.402653Z","caller":"traceutil/trace.go:171","msg":"trace[465484984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"260.526549ms","start":"2026-02-10T18:52:02.14212Z","end":"2026-02-10T18:52:02.402646Z","steps":["trace[465484984] 'agreement among raft nodes before linearized reading'  (duration: 259.467235ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:03.893996Z","caller":"traceutil/trace.go:171","msg":"trace[487866529] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"245.504234ms","start":"2026-02-10T18:52:03.648467Z","end":"2026-02-10T18:52:03.893971Z","steps":["trace[487866529] 'process raft request'  (duration: 245.368711ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:04.018415Z","caller":"traceutil/trace.go:171","msg":"trace[2047465797] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"194.45525ms","start":"2026-02-10T18:52:03.823941Z","end":"2026-02-10T18:52:04.018396Z","steps":["trace[2047465797] 'read index received'  (duration: 70.105091ms)","trace[2047465797] 'applied index is now lower than readState.Index'  (duration: 124.348979ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:04.018537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.574893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:04.01857Z","caller":"traceutil/trace.go:171","msg":"trace[673485505] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:600; }","duration":"194.647905ms","start":"2026-02-10T18:52:03.823909Z","end":"2026-02-10T18:52:04.018557Z","steps":["trace[673485505] 'agreement among raft nodes before linearized reading'  (duration: 194.560573ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:04.018679Z","caller":"traceutil/trace.go:171","msg":"trace[304233850] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"314.53316ms","start":"2026-02-10T18:52:03.704136Z","end":"2026-02-10T18:52:04.018669Z","steps":["trace[304233850] 'process raft request'  (duration: 314.157252ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:04.018797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:03.704118Z","time spent":"314.579421ms","remote":"127.0.0.1:50912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:598 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:4227 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" > >"}
{"level":"info","ts":"2026-02-10T18:52:10.618165Z","caller":"traceutil/trace.go:171","msg":"trace[1910634810] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"103.08823ms","start":"2026-02-10T18:52:10.515065Z","end":"2026-02-10T18:52:10.618153Z","steps":["trace[1910634810] 'process raft request'  (duration: 102.972147ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:10.652085Z","caller":"traceutil/trace.go:171","msg":"trace[1097839221] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"134.096383ms","start":"2026-02-10T18:52:10.517964Z","end":"2026-02-10T18:52:10.65206Z","steps":["trace[1097839221] 'process raft request'  (duration: 133.833257ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:12.925409Z","caller":"traceutil/trace.go:171","msg":"trace[331598355] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"104.575374ms","start":"2026-02-10T18:52:12.820816Z","end":"2026-02-10T18:52:12.925391Z","steps":["trace[331598355] 'process raft request'  (duration: 104.522313ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:12.925426Z","caller":"traceutil/trace.go:171","msg":"trace[1508786662] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"106.834226ms","start":"2026-02-10T18:52:12.818568Z","end":"2026-02-10T18:52:12.925402Z","steps":["trace[1508786662] 'process raft request'  (duration: 104.051542ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:12.980679Z","caller":"traceutil/trace.go:171","msg":"trace[936922606] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"146.175721ms","start":"2026-02-10T18:52:12.834486Z","end":"2026-02-10T18:52:12.980662Z","steps":["trace[936922606] 'process raft request'  (duration: 146.079258ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:13.108848Z","caller":"traceutil/trace.go:171","msg":"trace[1118718874] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:716; }","duration":"119.404635ms","start":"2026-02-10T18:52:12.989431Z","end":"2026-02-10T18:52:13.108835Z","steps":["trace[1118718874] 'read index received'  (duration: 48.25945ms)","trace[1118718874] 'applied index is now lower than readState.Index'  (duration: 71.144705ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:13.108918Z","caller":"traceutil/trace.go:171","msg":"trace[884162258] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"119.60369ms","start":"2026-02-10T18:52:12.98929Z","end":"2026-02-10T18:52:13.108894Z","steps":["trace[884162258] 'process raft request'  (duration: 119.437026ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:13.108986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.539898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-ssqlv\" ","response":"range_response_count:1 size:4733"}
{"level":"info","ts":"2026-02-10T18:52:13.109011Z","caller":"traceutil/trace.go:171","msg":"trace[1862261882] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-ssqlv; range_end:; response_count:1; response_revision:698; }","duration":"119.591089ms","start":"2026-02-10T18:52:12.989411Z","end":"2026-02-10T18:52:13.109003Z","steps":["trace[1862261882] 'agreement among raft nodes before linearized reading'  (duration: 119.480766ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:13.109208Z","caller":"traceutil/trace.go:171","msg":"trace[76513279] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"118.603717ms","start":"2026-02-10T18:52:12.990598Z","end":"2026-02-10T18:52:13.109202Z","steps":["trace[76513279] 'process raft request'  (duration: 118.207177ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:13.868605Z","caller":"traceutil/trace.go:171","msg":"trace[1258892178] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"115.403413ms","start":"2026-02-10T18:52:13.753187Z","end":"2026-02-10T18:52:13.86859Z","steps":["trace[1258892178] 'process raft request'  (duration: 115.367673ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:13.868857Z","caller":"traceutil/trace.go:171","msg":"trace[1845256265] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"115.837513ms","start":"2026-02-10T18:52:13.753014Z","end":"2026-02-10T18:52:13.868851Z","steps":["trace[1845256265] 'process raft request'  (duration: 87.275727ms)","trace[1845256265] 'compare'  (duration: 28.211298ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:14.752748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.356079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-10T18:52:14.752744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.013267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:14.752795Z","caller":"traceutil/trace.go:171","msg":"trace[705871957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:717; }","duration":"124.427ms","start":"2026-02-10T18:52:14.628355Z","end":"2026-02-10T18:52:14.752782Z","steps":["trace[705871957] 'range keys from in-memory index tree'  (duration: 124.297037ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:14.752825Z","caller":"traceutil/trace.go:171","msg":"trace[312217247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:717; }","duration":"712.12093ms","start":"2026-02-10T18:52:14.040684Z","end":"2026-02-10T18:52:14.752805Z","steps":["trace[312217247] 'range keys from in-memory index tree'  (duration: 711.937436ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:14.752863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.040671Z","time spent":"712.183882ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-10T18:52:14.85955Z","caller":"traceutil/trace.go:171","msg":"trace[1065050704] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"173.627531ms","start":"2026-02-10T18:52:14.68591Z","end":"2026-02-10T18:52:14.859538Z","steps":["trace[1065050704] 'process raft request'  (duration: 173.534449ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:14.859774Z","caller":"traceutil/trace.go:171","msg":"trace[483545602] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:739; }","duration":"146.476727ms","start":"2026-02-10T18:52:14.713292Z","end":"2026-02-10T18:52:14.859768Z","steps":["trace[483545602] 'read index received'  (duration: 146.474387ms)","trace[483545602] 'applied index is now lower than readState.Index'  (duration: 2.01µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:14.859872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.569119ms","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-02-10T18:52:14.859888Z","caller":"traceutil/trace.go:171","msg":"trace[284802623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:718; }","duration":"146.6086ms","start":"2026-02-10T18:52:14.713274Z","end":"2026-02-10T18:52:14.859883Z","steps":["trace[284802623] 'agreement among raft nodes before linearized reading'  (duration: 146.523438ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.359965Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813193416,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T18:52:15.765181Z","caller":"traceutil/trace.go:171","msg":"trace[1429950348] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"1.008903693s","start":"2026-02-10T18:52:14.756262Z","end":"2026-02-10T18:52:15.765165Z","steps":["trace[1429950348] 'process raft request'  (duration: 1.008814591s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.765276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.756253Z","time spent":"1.008972474s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:681 > 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-02-10T18:52:15.877852Z","caller":"traceutil/trace.go:171","msg":"trace[502090442] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:740; }","duration":"1.018031782s","start":"2026-02-10T18:52:14.859786Z","end":"2026-02-10T18:52:15.877817Z","steps":["trace[502090442] 'read index received'  (duration: 905.395833ms)","trace[502090442] 'applied index is now lower than readState.Index'  (duration: 112.635219ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:15.878037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100948558s","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-02-10T18:52:15.878059Z","caller":"traceutil/trace.go:171","msg":"trace[1572151958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:720; }","duration":"1.101006889s","start":"2026-02-10T18:52:14.777045Z","end":"2026-02-10T18:52:15.878052Z","steps":["trace[1572151958] 'agreement among raft nodes before linearized reading'  (duration: 1.100885616s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.878082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.777035Z","time spent":"1.101041651s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:15.878109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038515363s","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-02-10T18:52:15.878182Z","caller":"traceutil/trace.go:171","msg":"trace[109397329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:720; }","duration":"1.038629326s","start":"2026-02-10T18:52:14.839534Z","end":"2026-02-10T18:52:15.878163Z","steps":["trace[109397329] 'agreement among raft nodes before linearized reading'  (duration: 1.03838201s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.878251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.122681428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-10T18:52:15.878238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.839519Z","time spent":"1.038697857s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-10T18:52:15.878273Z","caller":"traceutil/trace.go:171","msg":"trace[578176568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"1.12278547s","start":"2026-02-10T18:52:14.755479Z","end":"2026-02-10T18:52:15.878265Z","steps":["trace[578176568] 'agreement among raft nodes before linearized reading'  (duration: 1.122755529s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.87829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.755468Z","time spent":"1.122817941s","remote":"127.0.0.1:50858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:52:15.878421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.270219ms","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-02-10T18:52:15.87844Z","caller":"traceutil/trace.go:171","msg":"trace[253642692] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:720; }","duration":"948.313039ms","start":"2026-02-10T18:52:14.930122Z","end":"2026-02-10T18:52:15.878435Z","steps":["trace[253642692] 'agreement among raft nodes before linearized reading'  (duration: 948.255568ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.878456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.93011Z","time spent":"948.34273ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:15.878564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.410127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:15.87857Z","caller":"traceutil/trace.go:171","msg":"trace[127294497] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"1.016109878s","start":"2026-02-10T18:52:14.86245Z","end":"2026-02-10T18:52:15.87856Z","steps":["trace[127294497] 'process raft request'  (duration: 1.00356399s)","trace[127294497] 'compare'  (duration: 11.727129ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:15.878581Z","caller":"traceutil/trace.go:171","msg":"trace[970976783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"702.444367ms","start":"2026-02-10T18:52:15.176131Z","end":"2026-02-10T18:52:15.878575Z","steps":["trace[970976783] 'agreement among raft nodes before linearized reading'  (duration: 702.415967ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:15.878599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:15.176115Z","time spent":"702.480359ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:52:15.878632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:14.862437Z","time spent":"1.016152399s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:682 > 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-02-10T18:52:17.976022Z","caller":"traceutil/trace.go:171","msg":"trace[173334807] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"647.855512ms","start":"2026-02-10T18:52:17.328154Z","end":"2026-02-10T18:52:17.97601Z","steps":["trace[173334807] 'process raft request'  (duration: 647.791221ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:17.976106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.328136Z","time spent":"647.935754ms","remote":"127.0.0.1:50942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-5dd5756b68-45g2p.1892f752867f1257\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-5dd5756b68-45g2p.1892f752867f1257\" value_size:729 lease:6890116316813192441 >> failure:<>"}
{"level":"info","ts":"2026-02-10T18:52:18.470702Z","caller":"traceutil/trace.go:171","msg":"trace[1546611752] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"1.023229551s","start":"2026-02-10T18:52:17.447447Z","end":"2026-02-10T18:52:18.470676Z","steps":["trace[1546611752] 'process raft request'  (duration: 976.228291ms)","trace[1546611752] 'compare'  (duration: 46.700583ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:18.47086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.447425Z","time spent":"1.023339794s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:644 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-10T18:52:18.853963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.471116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193428 > lease_revoke:<id:5f9e9c48e4c5efa1>","response":"size:28"}
{"level":"info","ts":"2026-02-10T18:52:18.854022Z","caller":"traceutil/trace.go:171","msg":"trace[424253824] linearizableReadLoop","detail":"{readStateIndex:747; appliedIndex:745; }","duration":"1.085613536s","start":"2026-02-10T18:52:17.768398Z","end":"2026-02-10T18:52:18.854011Z","steps":["trace[424253824] 'read index received'  (duration: 207.875248ms)","trace[424253824] 'applied index is now lower than readState.Index'  (duration: 877.737438ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:18.854181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08577728s","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-02-10T18:52:18.854195Z","caller":"traceutil/trace.go:171","msg":"trace[608420248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:725; }","duration":"1.08579847s","start":"2026-02-10T18:52:17.768392Z","end":"2026-02-10T18:52:18.85419Z","steps":["trace[608420248] 'agreement among raft nodes before linearized reading'  (duration: 1.085721929s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:18.854202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.975621ms","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-02-10T18:52:18.854212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.768343Z","time spent":"1.085864942s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-10T18:52:18.854221Z","caller":"traceutil/trace.go:171","msg":"trace[503374380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:725; }","duration":"971.040173ms","start":"2026-02-10T18:52:17.883175Z","end":"2026-02-10T18:52:18.854215Z","steps":["trace[503374380] 'agreement among raft nodes before linearized reading'  (duration: 970.989252ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:18.854235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.883152Z","time spent":"971.079473ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-10T18:52:18.854319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.193142ms","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-02-10T18:52:18.854331Z","caller":"traceutil/trace.go:171","msg":"trace[460107767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:725; }","duration":"906.215032ms","start":"2026-02-10T18:52:17.948112Z","end":"2026-02-10T18:52:18.854327Z","steps":["trace[460107767] 'agreement among raft nodes before linearized reading'  (duration: 906.178182ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:18.854342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.948107Z","time spent":"906.232933ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:18.854345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.53227ms","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-02-10T18:52:18.854358Z","caller":"traceutil/trace.go:171","msg":"trace[341357970] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:725; }","duration":"906.56952ms","start":"2026-02-10T18:52:17.947785Z","end":"2026-02-10T18:52:18.854354Z","steps":["trace[341357970] 'agreement among raft nodes before linearized reading'  (duration: 906.532219ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:18.85437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.947773Z","time spent":"906.594011ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:18.854402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.490611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:18.854415Z","caller":"traceutil/trace.go:171","msg":"trace[154075784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:725; }","duration":"813.530991ms","start":"2026-02-10T18:52:18.04088Z","end":"2026-02-10T18:52:18.854411Z","steps":["trace[154075784] 'agreement among raft nodes before linearized reading'  (duration: 813.512011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:18.854427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.040851Z","time spent":"813.573663ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:52:18.854437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.785344ms","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-02-10T18:52:18.854449Z","caller":"traceutil/trace.go:171","msg":"trace[1027346710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:725; }","duration":"939.822695ms","start":"2026-02-10T18:52:17.914623Z","end":"2026-02-10T18:52:18.854445Z","steps":["trace[1027346710] 'agreement among raft nodes before linearized reading'  (duration: 939.790574ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:18.854462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:17.914609Z","time spent":"939.849325ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:19.358663Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813193430,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T18:52:19.445064Z","caller":"traceutil/trace.go:171","msg":"trace[216064883] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"587.25587ms","start":"2026-02-10T18:52:18.857789Z","end":"2026-02-10T18:52:19.445045Z","steps":["trace[216064883] 'process raft request'  (duration: 587.139347ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:19.44517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.857776Z","time spent":"587.337811ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:719 > 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-02-10T18:52:19.835259Z","caller":"traceutil/trace.go:171","msg":"trace[671454364] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:747; }","duration":"977.231114ms","start":"2026-02-10T18:52:18.858007Z","end":"2026-02-10T18:52:19.835238Z","steps":["trace[671454364] 'read index received'  (duration: 586.996304ms)","trace[671454364] 'applied index is now lower than readState.Index'  (duration: 390.23401ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:19.83539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.360287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:19.835362Z","caller":"traceutil/trace.go:171","msg":"trace[922354448] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"975.614817ms","start":"2026-02-10T18:52:18.859701Z","end":"2026-02-10T18:52:19.835315Z","steps":["trace[922354448] 'process raft request'  (duration: 975.460224ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:19.835414Z","caller":"traceutil/trace.go:171","msg":"trace[703873293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:730; }","duration":"977.411198ms","start":"2026-02-10T18:52:18.857995Z","end":"2026-02-10T18:52:19.835406Z","steps":["trace[703873293] 'agreement among raft nodes before linearized reading'  (duration: 977.341797ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:19.835457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.857991Z","time spent":"977.459369ms","remote":"127.0.0.1:50858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:52:19.835544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.859694Z","time spent":"975.73779ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:721 > 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-02-10T18:52:19.83563Z","caller":"traceutil/trace.go:171","msg":"trace[834263731] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"975.069705ms","start":"2026-02-10T18:52:18.860552Z","end":"2026-02-10T18:52:19.835621Z","steps":["trace[834263731] 'process raft request'  (duration: 974.636015ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:19.835695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.860546Z","time spent":"975.102736ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:722 > 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-02-10T18:52:19.835753Z","caller":"traceutil/trace.go:171","msg":"trace[1533238350] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"975.123206ms","start":"2026-02-10T18:52:18.860624Z","end":"2026-02-10T18:52:19.835747Z","steps":["trace[1533238350] 'process raft request'  (duration: 974.585724ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:19.835785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.860619Z","time spent":"975.149037ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:723 > 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-02-10T18:52:19.835972Z","caller":"traceutil/trace.go:171","msg":"trace[1329649144] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"977.990062ms","start":"2026-02-10T18:52:18.857975Z","end":"2026-02-10T18:52:19.835965Z","steps":["trace[1329649144] 'process raft request'  (duration: 977.060631ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:19.836009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:18.857967Z","time spent":"978.020723ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:720 > 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-02-10T18:52:20.022382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.858321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:20.022436Z","caller":"traceutil/trace.go:171","msg":"trace[1834558278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:730; }","duration":"174.945662ms","start":"2026-02-10T18:52:19.847477Z","end":"2026-02-10T18:52:20.022423Z","steps":["trace[1834558278] 'range keys from in-memory index tree'  (duration: 174.8073ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:23.024296Z","caller":"traceutil/trace.go:171","msg":"trace[568328921] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"191.686087ms","start":"2026-02-10T18:52:22.832593Z","end":"2026-02-10T18:52:23.024279Z","steps":["trace[568328921] 'process raft request'  (duration: 191.604485ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:36.521694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.874873ms","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-02-10T18:52:36.52177Z","caller":"traceutil/trace.go:171","msg":"trace[621040503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:778; }","duration":"438.977895ms","start":"2026-02-10T18:52:36.082778Z","end":"2026-02-10T18:52:36.521756Z","steps":["trace[621040503] 'range keys from in-memory index tree'  (duration: 438.74327ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:36.521856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.56572ms","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-02-10T18:52:36.522157Z","caller":"traceutil/trace.go:171","msg":"trace[1848030808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:778; }","duration":"410.893957ms","start":"2026-02-10T18:52:36.111255Z","end":"2026-02-10T18:52:36.522149Z","steps":["trace[1848030808] 'range keys from in-memory index tree'  (duration: 410.465267ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:36.522184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:36.111238Z","time spent":"410.940709ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:36.521899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:36.082769Z","time spent":"439.123959ms","remote":"127.0.0.1:51126","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-02-10T18:52:36.52192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.087887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:36.522345Z","caller":"traceutil/trace.go:171","msg":"trace[1743404234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:778; }","duration":"480.516818ms","start":"2026-02-10T18:52:36.041806Z","end":"2026-02-10T18:52:36.522323Z","steps":["trace[1743404234] 'range keys from in-memory index tree'  (duration: 480.034776ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:36.522404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:36.041794Z","time spent":"480.58929ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:52:36.52198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.818311ms","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-02-10T18:52:36.522512Z","caller":"traceutil/trace.go:171","msg":"trace[2060287741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"480.374665ms","start":"2026-02-10T18:52:36.04213Z","end":"2026-02-10T18:52:36.522505Z","steps":["trace[2060287741] 'range keys from in-memory index tree'  (duration: 479.719769ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:36.522533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:36.042114Z","time spent":"480.412845ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-10T18:52:36.791785Z","caller":"traceutil/trace.go:171","msg":"trace[1143042665] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:804; }","duration":"162.981083ms","start":"2026-02-10T18:52:36.628788Z","end":"2026-02-10T18:52:36.791769Z","steps":["trace[1143042665] 'read index received'  (duration: 78.803089ms)","trace[1143042665] 'applied index is now lower than readState.Index'  (duration: 84.177244ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:36.791887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.080265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-10T18:52:36.79192Z","caller":"traceutil/trace.go:171","msg":"trace[1830860705] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:781; }","duration":"163.126826ms","start":"2026-02-10T18:52:36.628785Z","end":"2026-02-10T18:52:36.791912Z","steps":["trace[1830860705] 'agreement among raft nodes before linearized reading'  (duration: 163.043144ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:36.792122Z","caller":"traceutil/trace.go:171","msg":"trace[1637997935] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"263.988334ms","start":"2026-02-10T18:52:36.528125Z","end":"2026-02-10T18:52:36.792113Z","steps":["trace[1637997935] 'process raft request'  (duration: 179.524134ms)","trace[1637997935] 'compare'  (duration: 83.995968ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:36.792202Z","caller":"traceutil/trace.go:171","msg":"trace[1322986080] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"264.003555ms","start":"2026-02-10T18:52:36.528194Z","end":"2026-02-10T18:52:36.792197Z","steps":["trace[1322986080] 'process raft request'  (duration: 263.545394ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:37.926121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.216829ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193594 > lease_revoke:<id:5f9e9c48e4c5f0fa>","response":"size:28"}
{"level":"info","ts":"2026-02-10T18:52:37.926194Z","caller":"traceutil/trace.go:171","msg":"trace[172528705] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"371.320563ms","start":"2026-02-10T18:52:37.55486Z","end":"2026-02-10T18:52:37.926181Z","steps":["trace[172528705] 'read index received'  (duration: 39.491µs)","trace[172528705] 'applied index is now lower than readState.Index'  (duration: 371.279992ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:37.926323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.459687ms","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-02-10T18:52:37.926345Z","caller":"traceutil/trace.go:171","msg":"trace[582168835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"371.525139ms","start":"2026-02-10T18:52:37.554814Z","end":"2026-02-10T18:52:37.926339Z","steps":["trace[582168835] 'agreement among raft nodes before linearized reading'  (duration: 371.412206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:37.926372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:37.554797Z","time spent":"371.56959ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-10T18:52:40.492481Z","caller":"traceutil/trace.go:171","msg":"trace[1411564927] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"499.001588ms","start":"2026-02-10T18:52:39.993455Z","end":"2026-02-10T18:52:40.492456Z","steps":["trace[1411564927] 'read index received'  (duration: 498.883165ms)","trace[1411564927] 'applied index is now lower than readState.Index'  (duration: 117.593µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:40.492562Z","caller":"traceutil/trace.go:171","msg":"trace[733290576] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"528.174094ms","start":"2026-02-10T18:52:39.964383Z","end":"2026-02-10T18:52:40.492557Z","steps":["trace[733290576] 'process raft request'  (duration: 527.959618ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:40.492637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:39.96437Z","time spent":"528.207644ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:782 > 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":"warn","ts":"2026-02-10T18:52:40.492672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.612064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:40.492721Z","caller":"traceutil/trace.go:171","msg":"trace[1946912906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:788; }","duration":"452.688806ms","start":"2026-02-10T18:52:40.040019Z","end":"2026-02-10T18:52:40.492708Z","steps":["trace[1946912906] 'agreement among raft nodes before linearized reading'  (duration: 452.610034ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:40.492747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:40.040009Z","time spent":"452.733397ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:52:40.492874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.416028ms","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-02-10T18:52:40.492893Z","caller":"traceutil/trace.go:171","msg":"trace[35954940] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"499.435169ms","start":"2026-02-10T18:52:39.993452Z","end":"2026-02-10T18:52:40.492887Z","steps":["trace[35954940] 'agreement among raft nodes before linearized reading'  (duration: 499.363397ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:40.492912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:39.993425Z","time spent":"499.480199ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-10T18:52:41.129373Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813193617,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T18:52:41.424335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.159572ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193618 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:783 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T18:52:41.424396Z","caller":"traceutil/trace.go:171","msg":"trace[744565193] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"796.108196ms","start":"2026-02-10T18:52:40.628278Z","end":"2026-02-10T18:52:41.424386Z","steps":["trace[744565193] 'read index received'  (duration: 518.79327ms)","trace[744565193] 'applied index is now lower than readState.Index'  (duration: 277.314346ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:41.424522Z","caller":"traceutil/trace.go:171","msg":"trace[181588775] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"927.932324ms","start":"2026-02-10T18:52:40.496582Z","end":"2026-02-10T18:52:41.424514Z","steps":["trace[181588775] 'process raft request'  (duration: 650.544146ms)","trace[181588775] 'compare'  (duration: 276.864235ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:41.424558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:40.496567Z","time spent":"927.971915ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:783 > 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-02-10T18:52:41.424869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.68742ms","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-02-10T18:52:41.424892Z","caller":"traceutil/trace.go:171","msg":"trace[31205778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"796.745982ms","start":"2026-02-10T18:52:40.628139Z","end":"2026-02-10T18:52:41.424885Z","steps":["trace[31205778] 'agreement among raft nodes before linearized reading'  (duration: 796.510636ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:41.424949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:40.628116Z","time spent":"796.826613ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:41.425162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.430979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:41.425293Z","caller":"traceutil/trace.go:171","msg":"trace[1885441868] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:789; }","duration":"725.455699ms","start":"2026-02-10T18:52:40.699722Z","end":"2026-02-10T18:52:41.425178Z","steps":["trace[1885441868] 'agreement among raft nodes before linearized reading'  (duration: 725.409098ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:41.42532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:40.699652Z","time spent":"725.660595ms","remote":"127.0.0.1:51214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-10T18:52:41.425444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.166676ms","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-02-10T18:52:41.425461Z","caller":"traceutil/trace.go:171","msg":"trace[1902764822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"617.208887ms","start":"2026-02-10T18:52:40.808247Z","end":"2026-02-10T18:52:41.425456Z","steps":["trace[1902764822] 'agreement among raft nodes before linearized reading'  (duration: 617.153836ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:41.425477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:40.808235Z","time spent":"617.238188ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:41.425543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.72187ms","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-02-10T18:52:41.425558Z","caller":"traceutil/trace.go:171","msg":"trace[1944573923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:789; }","duration":"619.769261ms","start":"2026-02-10T18:52:40.805783Z","end":"2026-02-10T18:52:41.425552Z","steps":["trace[1944573923] 'agreement among raft nodes before linearized reading'  (duration: 619.72747ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:41.425599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:40.805764Z","time spent":"619.831833ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-10T18:52:41.70951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.232513ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193622 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:785 > 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-02-10T18:52:41.709652Z","caller":"traceutil/trace.go:171","msg":"trace[289078479] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"277.48086ms","start":"2026-02-10T18:52:41.432155Z","end":"2026-02-10T18:52:41.709636Z","steps":["trace[289078479] 'process raft request'  (duration: 110.866057ms)","trace[289078479] 'compare'  (duration: 166.130931ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:41.709896Z","caller":"traceutil/trace.go:171","msg":"trace[1106776994] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"277.174702ms","start":"2026-02-10T18:52:41.432715Z","end":"2026-02-10T18:52:41.709889Z","steps":["trace[1106776994] 'process raft request'  (duration: 276.875965ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:45.697692Z","caller":"traceutil/trace.go:171","msg":"trace[436683797] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:827; }","duration":"175.766461ms","start":"2026-02-10T18:52:45.521904Z","end":"2026-02-10T18:52:45.69767Z","steps":["trace[436683797] 'read index received'  (duration: 175.627727ms)","trace[436683797] 'applied index is now lower than readState.Index'  (duration: 137.654µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:52:45.697956Z","caller":"traceutil/trace.go:171","msg":"trace[105146309] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"259.314468ms","start":"2026-02-10T18:52:45.438612Z","end":"2026-02-10T18:52:45.697926Z","steps":["trace[105146309] 'process raft request'  (duration: 258.921008ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:45.698427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.448138ms","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-02-10T18:52:45.698948Z","caller":"traceutil/trace.go:171","msg":"trace[1738255622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:801; }","duration":"177.062043ms","start":"2026-02-10T18:52:45.521867Z","end":"2026-02-10T18:52:45.698929Z","steps":["trace[1738255622] 'agreement among raft nodes before linearized reading'  (duration: 176.174461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:45.698844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.214298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:45.699188Z","caller":"traceutil/trace.go:171","msg":"trace[1079091437] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:801; }","duration":"132.595497ms","start":"2026-02-10T18:52:45.566579Z","end":"2026-02-10T18:52:45.699175Z","steps":["trace[1079091437] 'agreement among raft nodes before linearized reading'  (duration: 132.227428ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:46.006496Z","caller":"traceutil/trace.go:171","msg":"trace[1539126353] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"283.038298ms","start":"2026-02-10T18:52:45.723441Z","end":"2026-02-10T18:52:46.006479Z","steps":["trace[1539126353] 'read index received'  (duration: 244.863839ms)","trace[1539126353] 'applied index is now lower than readState.Index'  (duration: 38.173739ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:46.006755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.293324ms","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":"warn","ts":"2026-02-10T18:52:46.006812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.939302ms","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-02-10T18:52:46.006842Z","caller":"traceutil/trace.go:171","msg":"trace[1735881617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"277.990023ms","start":"2026-02-10T18:52:45.728844Z","end":"2026-02-10T18:52:46.006834Z","steps":["trace[1735881617] 'agreement among raft nodes before linearized reading'  (duration: 277.87101ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:46.006842Z","caller":"traceutil/trace.go:171","msg":"trace[1607195755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"283.412367ms","start":"2026-02-10T18:52:45.723408Z","end":"2026-02-10T18:52:46.00682Z","steps":["trace[1607195755] 'agreement among raft nodes before linearized reading'  (duration: 283.181892ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:46.006965Z","caller":"traceutil/trace.go:171","msg":"trace[137685026] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"303.360874ms","start":"2026-02-10T18:52:45.703591Z","end":"2026-02-10T18:52:46.006952Z","steps":["trace[137685026] 'process raft request'  (duration: 264.762854ms)","trace[137685026] 'compare'  (duration: 38.051536ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:46.007039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:45.703577Z","time spent":"303.409894ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:797 > 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-02-10T18:52:46.409869Z","caller":"traceutil/trace.go:171","msg":"trace[1493881126] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:829; }","duration":"367.396255ms","start":"2026-02-10T18:52:46.042459Z","end":"2026-02-10T18:52:46.409856Z","steps":["trace[1493881126] 'read index received'  (duration: 280.840962ms)","trace[1493881126] 'applied index is now lower than readState.Index'  (duration: 86.554753ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:46.409963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.498438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:52:46.409979Z","caller":"traceutil/trace.go:171","msg":"trace[1663221596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"367.561069ms","start":"2026-02-10T18:52:46.042413Z","end":"2026-02-10T18:52:46.409975Z","steps":["trace[1663221596] 'agreement among raft nodes before linearized reading'  (duration: 367.504327ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:46.409996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:46.042378Z","time spent":"367.61388ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-10T18:52:46.410155Z","caller":"traceutil/trace.go:171","msg":"trace[297082865] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"397.3602ms","start":"2026-02-10T18:52:46.012786Z","end":"2026-02-10T18:52:46.410146Z","steps":["trace[297082865] 'process raft request'  (duration: 310.50411ms)","trace[297082865] 'compare'  (duration: 86.122832ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:46.410198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:46.012765Z","time spent":"397.403331ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:799 > 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-02-10T18:52:46.410268Z","caller":"traceutil/trace.go:171","msg":"trace[256480388] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"397.461813ms","start":"2026-02-10T18:52:46.012803Z","end":"2026-02-10T18:52:46.410264Z","steps":["trace[256480388] 'process raft request'  (duration: 397.013262ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:46.410292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:46.01278Z","time spent":"397.497793ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:798 > 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":"warn","ts":"2026-02-10T18:52:46.925078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.250344ms","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-02-10T18:52:46.925153Z","caller":"traceutil/trace.go:171","msg":"trace[1054671397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:804; }","duration":"281.382427ms","start":"2026-02-10T18:52:46.643752Z","end":"2026-02-10T18:52:46.925135Z","steps":["trace[1054671397] 'range keys from in-memory index tree'  (duration: 281.066479ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:57.891528Z","caller":"traceutil/trace.go:171","msg":"trace[1560688717] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"106.037587ms","start":"2026-02-10T18:52:57.785472Z","end":"2026-02-10T18:52:57.891509Z","steps":["trace[1560688717] 'process raft request'  (duration: 105.921634ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:59.347285Z","caller":"traceutil/trace.go:171","msg":"trace[835456422] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"240.537581ms","start":"2026-02-10T18:52:59.106732Z","end":"2026-02-10T18:52:59.34727Z","steps":["trace[835456422] 'process raft request'  (duration: 240.445699ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:52:59.347626Z","caller":"traceutil/trace.go:171","msg":"trace[617005911] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:922; }","duration":"138.550755ms","start":"2026-02-10T18:52:59.20907Z","end":"2026-02-10T18:52:59.34762Z","steps":["trace[617005911] 'read index received'  (duration: 138.548395ms)","trace[617005911] 'applied index is now lower than readState.Index'  (duration: 2.02µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:59.347672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.586977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-10T18:52:59.347688Z","caller":"traceutil/trace.go:171","msg":"trace[1071980618] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:890; }","duration":"138.637477ms","start":"2026-02-10T18:52:59.209044Z","end":"2026-02-10T18:52:59.347682Z","steps":["trace[1071980618] 'agreement among raft nodes before linearized reading'  (duration: 138.595016ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:52:59.686657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.139897ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193856 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:811 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T18:52:59.686718Z","caller":"traceutil/trace.go:171","msg":"trace[197625801] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"381.981469ms","start":"2026-02-10T18:52:59.304725Z","end":"2026-02-10T18:52:59.686707Z","steps":["trace[197625801] 'process raft request'  (duration: 259.745459ms)","trace[197625801] 'compare'  (duration: 122.071525ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:52:59.686746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:52:59.304709Z","time spent":"382.024739ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:811 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-10T18:53:00.177229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.428047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:00.177286Z","caller":"traceutil/trace.go:171","msg":"trace[1674407864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"137.52751ms","start":"2026-02-10T18:53:00.039747Z","end":"2026-02-10T18:53:00.177274Z","steps":["trace[1674407864] 'range keys from in-memory index tree'  (duration: 137.371016ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:00.508003Z","caller":"traceutil/trace.go:171","msg":"trace[227283248] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"328.100878ms","start":"2026-02-10T18:53:00.179889Z","end":"2026-02-10T18:53:00.507989Z","steps":["trace[227283248] 'process raft request'  (duration: 327.906163ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:00.508088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:00.179878Z","time spent":"328.165509ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:887 > 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-02-10T18:53:01.017448Z","caller":"traceutil/trace.go:171","msg":"trace[214580044] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"504.175637ms","start":"2026-02-10T18:53:00.513255Z","end":"2026-02-10T18:53:01.017431Z","steps":["trace[214580044] 'process raft request'  (duration: 504.012922ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:01.017599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:00.513202Z","time spent":"504.2958ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:888 > 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-02-10T18:53:01.040654Z","caller":"traceutil/trace.go:171","msg":"trace[584073788] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:926; }","duration":"183.529383ms","start":"2026-02-10T18:53:00.857107Z","end":"2026-02-10T18:53:01.040637Z","steps":["trace[584073788] 'read index received'  (duration: 161.435964ms)","trace[584073788] 'applied index is now lower than readState.Index'  (duration: 22.092469ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:01.040772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.659817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:01.040796Z","caller":"traceutil/trace.go:171","msg":"trace[132331995] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:895; }","duration":"183.732488ms","start":"2026-02-10T18:53:00.857056Z","end":"2026-02-10T18:53:01.040789Z","steps":["trace[132331995] 'agreement among raft nodes before linearized reading'  (duration: 183.652426ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:01.040963Z","caller":"traceutil/trace.go:171","msg":"trace[144852249] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"522.504232ms","start":"2026-02-10T18:53:00.518454Z","end":"2026-02-10T18:53:01.040958Z","steps":["trace[144852249] 'process raft request'  (duration: 522.116343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:01.041018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:00.518448Z","time spent":"522.537963ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:889 > 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-02-10T18:53:01.584916Z","caller":"traceutil/trace.go:171","msg":"trace[1982426536] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"218.960905ms","start":"2026-02-10T18:53:01.365937Z","end":"2026-02-10T18:53:01.584898Z","steps":["trace[1982426536] 'process raft request'  (duration: 218.846232ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:08.076196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.699982ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193921 > lease_revoke:<id:5f9e9c48e4c5f1e6>","response":"size:28"}
{"level":"info","ts":"2026-02-10T18:53:08.076278Z","caller":"traceutil/trace.go:171","msg":"trace[795924152] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:945; }","duration":"479.050601ms","start":"2026-02-10T18:53:07.597211Z","end":"2026-02-10T18:53:08.076262Z","steps":["trace[795924152] 'read index received'  (duration: 97.228787ms)","trace[795924152] 'applied index is now lower than readState.Index'  (duration: 381.820504ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:08.076787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.566204ms","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-02-10T18:53:08.076822Z","caller":"traceutil/trace.go:171","msg":"trace[1654541875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:912; }","duration":"479.626426ms","start":"2026-02-10T18:53:07.597185Z","end":"2026-02-10T18:53:08.076811Z","steps":["trace[1654541875] 'agreement among raft nodes before linearized reading'  (duration: 479.506803ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:08.076854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:07.597174Z","time spent":"479.670856ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-10T18:53:08.076966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.014001ms","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-02-10T18:53:08.076992Z","caller":"traceutil/trace.go:171","msg":"trace[405830666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:912; }","duration":"144.058602ms","start":"2026-02-10T18:53:07.932925Z","end":"2026-02-10T18:53:08.076983Z","steps":["trace[405830666] 'agreement among raft nodes before linearized reading'  (duration: 143.987ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:08.220658Z","caller":"traceutil/trace.go:171","msg":"trace[1581601694] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"138.645197ms","start":"2026-02-10T18:53:08.081994Z","end":"2026-02-10T18:53:08.220639Z","steps":["trace[1581601694] 'process raft request'  (duration: 138.525424ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:08.6649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.258811ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193926 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:908 > 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-02-10T18:53:08.664985Z","caller":"traceutil/trace.go:171","msg":"trace[1021482889] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:947; }","duration":"107.917273ms","start":"2026-02-10T18:53:08.557053Z","end":"2026-02-10T18:53:08.66497Z","steps":["trace[1021482889] 'read index received'  (duration: 26.48µs)","trace[1021482889] 'applied index is now lower than readState.Index'  (duration: 107.889773ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:08.665121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.065058ms","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-02-10T18:53:08.665148Z","caller":"traceutil/trace.go:171","msg":"trace[1901878470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:914; }","duration":"108.112338ms","start":"2026-02-10T18:53:08.557026Z","end":"2026-02-10T18:53:08.665139Z","steps":["trace[1901878470] 'agreement among raft nodes before linearized reading'  (duration: 107.985975ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:08.665515Z","caller":"traceutil/trace.go:171","msg":"trace[324674103] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"583.019197ms","start":"2026-02-10T18:53:08.082483Z","end":"2026-02-10T18:53:08.665502Z","steps":["trace[324674103] 'process raft request'  (duration: 246.091469ms)","trace[324674103] 'compare'  (duration: 335.892362ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:08.665577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:08.082473Z","time spent":"583.070638ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:908 > 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":"warn","ts":"2026-02-10T18:53:09.133899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.101893ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193928 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:910 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T18:53:09.134227Z","caller":"traceutil/trace.go:171","msg":"trace[575835135] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"461.133297ms","start":"2026-02-10T18:53:08.673077Z","end":"2026-02-10T18:53:09.134211Z","steps":["trace[575835135] 'process raft request'  (duration: 96.653034ms)","trace[575835135] 'compare'  (duration: 363.999771ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:09.13431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:08.673062Z","time spent":"461.199958ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:910 > 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-02-10T18:53:09.280222Z","caller":"traceutil/trace.go:171","msg":"trace[2106984121] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"139.519389ms","start":"2026-02-10T18:53:09.140679Z","end":"2026-02-10T18:53:09.280198Z","steps":["trace[2106984121] 'process raft request'  (duration: 98.816587ms)","trace[2106984121] 'compare'  (duration: 40.383954ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:09.948273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.944931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-10T18:53:09.948364Z","caller":"traceutil/trace.go:171","msg":"trace[998947243] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:917; }","duration":"463.087725ms","start":"2026-02-10T18:53:09.485257Z","end":"2026-02-10T18:53:09.948345Z","steps":["trace[998947243] 'count revisions from in-memory index tree'  (duration: 462.895941ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:09.948414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:09.485241Z","time spent":"463.155077ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"info","ts":"2026-02-10T18:53:10.513188Z","caller":"traceutil/trace.go:171","msg":"trace[1421894120] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:951; }","duration":"289.095589ms","start":"2026-02-10T18:53:10.224069Z","end":"2026-02-10T18:53:10.513164Z","steps":["trace[1421894120] 'read index received'  (duration: 288.908975ms)","trace[1421894120] 'applied index is now lower than readState.Index'  (duration: 185.484µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:10.513295Z","caller":"traceutil/trace.go:171","msg":"trace[473022358] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"617.915325ms","start":"2026-02-10T18:53:09.895371Z","end":"2026-02-10T18:53:10.513286Z","steps":["trace[473022358] 'process raft request'  (duration: 617.662929ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:10.513432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:09.895355Z","time spent":"617.964086ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:891 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-10T18:53:10.513812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.737835ms","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-02-10T18:53:10.513844Z","caller":"traceutil/trace.go:171","msg":"trace[1936748294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:918; }","duration":"289.803456ms","start":"2026-02-10T18:53:10.224031Z","end":"2026-02-10T18:53:10.513835Z","steps":["trace[1936748294] 'agreement among raft nodes before linearized reading'  (duration: 289.696433ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:10.861157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.019577ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193939 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:913 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T18:53:10.861253Z","caller":"traceutil/trace.go:171","msg":"trace[2017347690] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"188.453276ms","start":"2026-02-10T18:53:10.672786Z","end":"2026-02-10T18:53:10.861239Z","steps":["trace[2017347690] 'read index received'  (duration: 24.671µs)","trace[2017347690] 'applied index is now lower than readState.Index'  (duration: 188.427465ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:10.861418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.627491ms","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-02-10T18:53:10.861456Z","caller":"traceutil/trace.go:171","msg":"trace[639314233] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:919; }","duration":"188.672601ms","start":"2026-02-10T18:53:10.672764Z","end":"2026-02-10T18:53:10.861437Z","steps":["trace[639314233] 'agreement among raft nodes before linearized reading'  (duration: 188.515617ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:10.861696Z","caller":"traceutil/trace.go:171","msg":"trace[871674132] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"341.714957ms","start":"2026-02-10T18:53:10.51997Z","end":"2026-02-10T18:53:10.861685Z","steps":["trace[871674132] 'process raft request'  (duration: 85.101646ms)","trace[871674132] 'compare'  (duration: 255.697659ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:10.861751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:10.519956Z","time spent":"341.764908ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:913 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-10T18:53:11.02701Z","caller":"traceutil/trace.go:171","msg":"trace[171758193] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"160.672906ms","start":"2026-02-10T18:53:10.866319Z","end":"2026-02-10T18:53:11.026992Z","steps":["trace[171758193] 'process raft request'  (duration: 152.103253ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:11.434869Z","caller":"traceutil/trace.go:171","msg":"trace[773921895] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"116.309722ms","start":"2026-02-10T18:53:11.318529Z","end":"2026-02-10T18:53:11.434838Z","steps":["trace[773921895] 'process raft request'  (duration: 60.160956ms)","trace[773921895] 'compare'  (duration: 55.755617ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:12.156583Z","caller":"traceutil/trace.go:171","msg":"trace[57886483] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"117.791209ms","start":"2026-02-10T18:53:12.038771Z","end":"2026-02-10T18:53:12.156562Z","steps":["trace[57886483] 'read index received'  (duration: 117.646625ms)","trace[57886483] 'applied index is now lower than readState.Index'  (duration: 143.464µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:12.15669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.900271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:12.156723Z","caller":"traceutil/trace.go:171","msg":"trace[1316816525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:923; }","duration":"117.969834ms","start":"2026-02-10T18:53:12.038744Z","end":"2026-02-10T18:53:12.156714Z","steps":["trace[1316816525] 'agreement among raft nodes before linearized reading'  (duration: 117.899222ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.53474Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813193972,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T18:53:15.563106Z","caller":"traceutil/trace.go:171","msg":"trace[946709448] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:965; }","duration":"528.674248ms","start":"2026-02-10T18:53:15.034416Z","end":"2026-02-10T18:53:15.56309Z","steps":["trace[946709448] 'read index received'  (duration: 528.553736ms)","trace[946709448] 'applied index is now lower than readState.Index'  (duration: 120.002µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:15.563263Z","caller":"traceutil/trace.go:171","msg":"trace[170222992] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"688.698708ms","start":"2026-02-10T18:53:14.874559Z","end":"2026-02-10T18:53:15.563258Z","steps":["trace[170222992] 'process raft request'  (duration: 688.449103ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.563319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:14.874549Z","time spent":"688.72759ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:925 > 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-02-10T18:53:15.563445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.034167ms","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-02-10T18:53:15.56346Z","caller":"traceutil/trace.go:171","msg":"trace[1233789630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:931; }","duration":"529.084718ms","start":"2026-02-10T18:53:15.03437Z","end":"2026-02-10T18:53:15.563455Z","steps":["trace[1233789630] 'agreement among raft nodes before linearized reading'  (duration: 529.026227ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.563474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.034357Z","time spent":"529.113938ms","remote":"127.0.0.1:51126","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-02-10T18:53:15.563542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.07112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:15.563553Z","caller":"traceutil/trace.go:171","msg":"trace[1250030731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:931; }","duration":"326.105871ms","start":"2026-02-10T18:53:15.237444Z","end":"2026-02-10T18:53:15.56355Z","steps":["trace[1250030731] 'agreement among raft nodes before linearized reading'  (duration: 326.087551ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.563564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.237431Z","time spent":"326.131091ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:53:15.563689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.61493ms","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-02-10T18:53:15.563703Z","caller":"traceutil/trace.go:171","msg":"trace[1876876474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:931; }","duration":"118.650422ms","start":"2026-02-10T18:53:15.445048Z","end":"2026-02-10T18:53:15.563698Z","steps":["trace[1876876474] 'agreement among raft nodes before linearized reading'  (duration: 118.613591ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.563772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.652188ms","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-02-10T18:53:15.563783Z","caller":"traceutil/trace.go:171","msg":"trace[1460840748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:931; }","duration":"230.663449ms","start":"2026-02-10T18:53:15.333116Z","end":"2026-02-10T18:53:15.56378Z","steps":["trace[1460840748] 'agreement among raft nodes before linearized reading'  (duration: 230.632748ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.56385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.628567ms","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-02-10T18:53:15.56386Z","caller":"traceutil/trace.go:171","msg":"trace[140337473] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:931; }","duration":"302.661667ms","start":"2026-02-10T18:53:15.261196Z","end":"2026-02-10T18:53:15.563857Z","steps":["trace[140337473] 'agreement among raft nodes before linearized reading'  (duration: 302.628597ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:15.563871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.261183Z","time spent":"302.685539ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-10T18:53:16.577774Z","caller":"traceutil/trace.go:171","msg":"trace[555340427] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"1.009831905s","start":"2026-02-10T18:53:15.567924Z","end":"2026-02-10T18:53:16.577756Z","steps":["trace[555340427] 'process raft request'  (duration: 915.037137ms)","trace[555340427] 'compare'  (duration: 94.726746ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:16.577878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.567912Z","time spent":"1.009916878s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:927 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-10T18:53:16.800163Z","caller":"traceutil/trace.go:171","msg":"trace[956851933] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:966; }","duration":"761.233441ms","start":"2026-02-10T18:53:16.038913Z","end":"2026-02-10T18:53:16.800147Z","steps":["trace[956851933] 'read index received'  (duration: 444.057577ms)","trace[956851933] 'applied index is now lower than readState.Index'  (duration: 317.175194ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:16.80022Z","caller":"traceutil/trace.go:171","msg":"trace[1315540051] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"1.23215605s","start":"2026-02-10T18:53:15.568022Z","end":"2026-02-10T18:53:16.800178Z","steps":["trace[1315540051] 'process raft request'  (duration: 1.149234998s)","trace[1315540051] 'compare'  (duration: 82.750678ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:16.800251Z","caller":"traceutil/trace.go:171","msg":"trace[82766788] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"1.23039484s","start":"2026-02-10T18:53:15.56985Z","end":"2026-02-10T18:53:16.800245Z","steps":["trace[82766788] 'process raft request'  (duration: 1.230250456s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:16.800332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.569843Z","time spent":"1.23042979s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:928 > 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-02-10T18:53:16.800546Z","caller":"traceutil/trace.go:171","msg":"trace[1323910671] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"1.230563043s","start":"2026-02-10T18:53:15.569976Z","end":"2026-02-10T18:53:16.800539Z","steps":["trace[1323910671] 'process raft request'  (duration: 1.230147744s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:16.800603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.569952Z","time spent":"1.230616814s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:929 > 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-02-10T18:53:16.800739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.809025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:16.80076Z","caller":"traceutil/trace.go:171","msg":"trace[124982665] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:935; }","duration":"761.869095ms","start":"2026-02-10T18:53:16.038885Z","end":"2026-02-10T18:53:16.800754Z","steps":["trace[124982665] 'agreement among raft nodes before linearized reading'  (duration: 761.804164ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:16.800778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:16.038872Z","time spent":"761.901856ms","remote":"127.0.0.1:50858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:53:16.800889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.1588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-10T18:53:16.800907Z","caller":"traceutil/trace.go:171","msg":"trace[336742025] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:935; }","duration":"523.199972ms","start":"2026-02-10T18:53:16.277702Z","end":"2026-02-10T18:53:16.800902Z","steps":["trace[336742025] 'agreement among raft nodes before linearized reading'  (duration: 523.169761ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:16.800927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:16.277689Z","time spent":"523.231672ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-10T18:53:16.801211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.483934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:16.801232Z","caller":"traceutil/trace.go:171","msg":"trace[1045606611] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:935; }","duration":"164.533775ms","start":"2026-02-10T18:53:16.636692Z","end":"2026-02-10T18:53:16.801226Z","steps":["trace[1045606611] 'agreement among raft nodes before linearized reading'  (duration: 164.502505ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:16.80134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:15.568016Z","time spent":"1.232252412s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:926 > 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\" > >"}
{"level":"warn","ts":"2026-02-10T18:53:17.444705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.278507ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813193984 > lease_revoke:<id:5f9e9c48e4c5f293>","response":"size:28"}
{"level":"info","ts":"2026-02-10T18:53:18.439744Z","caller":"traceutil/trace.go:171","msg":"trace[648031565] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:971; }","duration":"393.79885ms","start":"2026-02-10T18:53:18.045928Z","end":"2026-02-10T18:53:18.439727Z","steps":["trace[648031565] 'read index received'  (duration: 393.607476ms)","trace[648031565] 'applied index is now lower than readState.Index'  (duration: 189.304µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:18.43985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.904863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:18.439885Z","caller":"traceutil/trace.go:171","msg":"trace[1331910223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:936; }","duration":"393.979874ms","start":"2026-02-10T18:53:18.045898Z","end":"2026-02-10T18:53:18.439877Z","steps":["trace[1331910223] 'agreement among raft nodes before linearized reading'  (duration: 393.897252ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:18.43991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:18.045883Z","time spent":"394.021246ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-10T18:53:18.44019Z","caller":"traceutil/trace.go:171","msg":"trace[1461810866] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"867.673898ms","start":"2026-02-10T18:53:17.572506Z","end":"2026-02-10T18:53:18.44018Z","steps":["trace[1461810866] 'process raft request'  (duration: 867.114585ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:18.44025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:17.572488Z","time spent":"867.719629ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:931 > 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-02-10T18:53:18.967639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.69048ms","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-02-10T18:53:18.967692Z","caller":"traceutil/trace.go:171","msg":"trace[597762428] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:936; }","duration":"384.785832ms","start":"2026-02-10T18:53:18.582893Z","end":"2026-02-10T18:53:18.967679Z","steps":["trace[597762428] 'range keys from in-memory index tree'  (duration: 384.565277ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:18.967721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:18.582879Z","time spent":"384.833593ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-10T18:53:18.967908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.754041ms","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-02-10T18:53:18.967925Z","caller":"traceutil/trace.go:171","msg":"trace[643049092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:936; }","duration":"158.780412ms","start":"2026-02-10T18:53:18.809139Z","end":"2026-02-10T18:53:18.96792Z","steps":["trace[643049092] 'range keys from in-memory index tree'  (duration: 158.70219ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:18.968024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.922045ms","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-02-10T18:53:18.968039Z","caller":"traceutil/trace.go:171","msg":"trace[2104787160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:936; }","duration":"158.963386ms","start":"2026-02-10T18:53:18.809071Z","end":"2026-02-10T18:53:18.968034Z","steps":["trace[2104787160] 'range keys from in-memory index tree'  (duration: 158.785522ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:18.968135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.932825ms","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-02-10T18:53:18.968166Z","caller":"traceutil/trace.go:171","msg":"trace[582082624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:936; }","duration":"158.955736ms","start":"2026-02-10T18:53:18.80919Z","end":"2026-02-10T18:53:18.968145Z","steps":["trace[582082624] 'range keys from in-memory index tree'  (duration: 158.888654ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:19.357485Z","caller":"traceutil/trace.go:171","msg":"trace[271499484] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"383.699977ms","start":"2026-02-10T18:53:18.973763Z","end":"2026-02-10T18:53:19.357463Z","steps":["trace[271499484] 'process raft request'  (duration: 383.519713ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:19.358152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:18.973746Z","time spent":"384.323821ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:933 > 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-02-10T18:53:19.383892Z","caller":"traceutil/trace.go:171","msg":"trace[1098419627] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"409.519936ms","start":"2026-02-10T18:53:18.974358Z","end":"2026-02-10T18:53:19.383878Z","steps":["trace[1098419627] 'process raft request'  (duration: 409.491835ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:19.383979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:18.974352Z","time spent":"409.583267ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:934 > 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-02-10T18:53:19.384144Z","caller":"traceutil/trace.go:171","msg":"trace[526772595] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"410.223732ms","start":"2026-02-10T18:53:18.973913Z","end":"2026-02-10T18:53:19.384137Z","steps":["trace[526772595] 'process raft request'  (duration: 407.030118ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:19.384178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:18.973908Z","time spent":"410.251312ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:932 > 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-02-10T18:53:19.384253Z","caller":"traceutil/trace.go:171","msg":"trace[543071513] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"410.287584ms","start":"2026-02-10T18:53:18.97396Z","end":"2026-02-10T18:53:19.384248Z","steps":["trace[543071513] 'process raft request'  (duration: 409.837033ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:19.386266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:18.973956Z","time spent":"410.309614ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:935 > 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-02-10T18:53:21.859799Z","caller":"traceutil/trace.go:171","msg":"trace[1076814297] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"470.679793ms","start":"2026-02-10T18:53:21.389104Z","end":"2026-02-10T18:53:21.859784Z","steps":["trace[1076814297] 'read index received'  (duration: 470.54216ms)","trace[1076814297] 'applied index is now lower than readState.Index'  (duration: 137.033µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:21.859876Z","caller":"traceutil/trace.go:171","msg":"trace[940976523] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"496.017131ms","start":"2026-02-10T18:53:21.363849Z","end":"2026-02-10T18:53:21.859867Z","steps":["trace[940976523] 'process raft request'  (duration: 495.835277ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:21.859944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:21.363838Z","time spent":"496.054382ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:937 > 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":"warn","ts":"2026-02-10T18:53:21.860078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.97336ms","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-02-10T18:53:21.860095Z","caller":"traceutil/trace.go:171","msg":"trace[1875551595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:951; }","duration":"471.013121ms","start":"2026-02-10T18:53:21.389076Z","end":"2026-02-10T18:53:21.860089Z","steps":["trace[1875551595] 'agreement among raft nodes before linearized reading'  (duration: 470.94745ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:21.860108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:21.389063Z","time spent":"471.042602ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-10T18:53:21.860165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.888443ms","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-02-10T18:53:21.860175Z","caller":"traceutil/trace.go:171","msg":"trace[1778105044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:951; }","duration":"465.898573ms","start":"2026-02-10T18:53:21.394273Z","end":"2026-02-10T18:53:21.860172Z","steps":["trace[1778105044] 'agreement among raft nodes before linearized reading'  (duration: 465.866192ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:21.860186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:21.39425Z","time spent":"465.933703ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T18:53:21.860229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.441965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-10T18:53:21.860242Z","caller":"traceutil/trace.go:171","msg":"trace[1650503864] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:951; }","duration":"102.488147ms","start":"2026-02-10T18:53:21.75775Z","end":"2026-02-10T18:53:21.860238Z","steps":["trace[1650503864] 'agreement among raft nodes before linearized reading'  (duration: 102.465076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:21.860368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.604916ms","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-02-10T18:53:21.860381Z","caller":"traceutil/trace.go:171","msg":"trace[652781656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:951; }","duration":"465.625937ms","start":"2026-02-10T18:53:21.394751Z","end":"2026-02-10T18:53:21.860377Z","steps":["trace[652781656] 'agreement among raft nodes before linearized reading'  (duration: 465.588686ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:21.860392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:21.394747Z","time spent":"465.642247ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:53:22.49781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.895032ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813194025 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:5f9e9c48e4c5f328>","response":"size:40"}
{"level":"info","ts":"2026-02-10T18:53:22.497895Z","caller":"traceutil/trace.go:171","msg":"trace[1852804842] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"458.289827ms","start":"2026-02-10T18:53:22.03959Z","end":"2026-02-10T18:53:22.49788Z","steps":["trace[1852804842] 'read index received'  (duration: 99.260122ms)","trace[1852804842] 'applied index is now lower than readState.Index'  (duration: 359.028325ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:22.49796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:22.012934Z","time spent":"485.024407ms","remote":"127.0.0.1:50886","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-10T18:53:22.498141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.542293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:22.498169Z","caller":"traceutil/trace.go:171","msg":"trace[863533341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:954; }","duration":"458.587093ms","start":"2026-02-10T18:53:22.039573Z","end":"2026-02-10T18:53:22.49816Z","steps":["trace[863533341] 'agreement among raft nodes before linearized reading'  (duration: 458.533292ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:22.498195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:22.039564Z","time spent":"458.625574ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-10T18:53:22.698432Z","caller":"traceutil/trace.go:171","msg":"trace[1635222491] linearizableReadLoop","detail":"{readStateIndex:993; appliedIndex:992; }","duration":"158.373453ms","start":"2026-02-10T18:53:22.540043Z","end":"2026-02-10T18:53:22.698416Z","steps":["trace[1635222491] 'read index received'  (duration: 158.237669ms)","trace[1635222491] 'applied index is now lower than readState.Index'  (duration: 135.114µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:22.698913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.834109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-10T18:53:22.699113Z","caller":"traceutil/trace.go:171","msg":"trace[1039689923] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:956; }","duration":"139.068005ms","start":"2026-02-10T18:53:22.560035Z","end":"2026-02-10T18:53:22.699103Z","steps":["trace[1039689923] 'agreement among raft nodes before linearized reading'  (duration: 138.829409ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:22.699259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.213532ms","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-02-10T18:53:22.699282Z","caller":"traceutil/trace.go:171","msg":"trace[1734372612] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:956; }","duration":"159.232332ms","start":"2026-02-10T18:53:22.540039Z","end":"2026-02-10T18:53:22.699271Z","steps":["trace[1734372612] 'agreement among raft nodes before linearized reading'  (duration: 159.183511ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:22.701648Z","caller":"traceutil/trace.go:171","msg":"trace[351882547] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"195.095644ms","start":"2026-02-10T18:53:22.503499Z","end":"2026-02-10T18:53:22.698594Z","steps":["trace[351882547] 'process raft request'  (duration: 194.825697ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:23.21557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.6608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:23.215628Z","caller":"traceutil/trace.go:171","msg":"trace[1881258095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:956; }","duration":"174.758512ms","start":"2026-02-10T18:53:23.040855Z","end":"2026-02-10T18:53:23.215613Z","steps":["trace[1881258095] 'range keys from in-memory index tree'  (duration: 174.587138ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:25.208536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813194053,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T18:53:25.231902Z","caller":"traceutil/trace.go:171","msg":"trace[8080856] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"524.265712ms","start":"2026-02-10T18:53:24.707615Z","end":"2026-02-10T18:53:25.231881Z","steps":["trace[8080856] 'read index received'  (duration: 524.106888ms)","trace[8080856] 'applied index is now lower than readState.Index'  (duration: 157.954µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:25.232191Z","caller":"traceutil/trace.go:171","msg":"trace[1767686473] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"616.51607ms","start":"2026-02-10T18:53:24.615663Z","end":"2026-02-10T18:53:25.232179Z","steps":["trace[1767686473] 'process raft request'  (duration: 616.11008ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:25.232282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:24.615646Z","time spent":"616.572321ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:930 > 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-02-10T18:53:25.232544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.923958ms","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-02-10T18:53:25.232576Z","caller":"traceutil/trace.go:171","msg":"trace[1325460267] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:967; }","duration":"524.980889ms","start":"2026-02-10T18:53:24.707586Z","end":"2026-02-10T18:53:25.232567Z","steps":["trace[1325460267] 'agreement among raft nodes before linearized reading'  (duration: 524.872716ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:25.232603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:24.707573Z","time spent":"525.02484ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-10T18:53:25.232775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.689862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4783"}
{"level":"info","ts":"2026-02-10T18:53:25.2328Z","caller":"traceutil/trace.go:171","msg":"trace[701062258] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:967; }","duration":"524.726003ms","start":"2026-02-10T18:53:24.708066Z","end":"2026-02-10T18:53:25.232792Z","steps":["trace[701062258] 'agreement among raft nodes before linearized reading'  (duration: 524.650601ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:25.232823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:24.708061Z","time spent":"524.757704ms","remote":"127.0.0.1:51040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4806,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-10T18:53:25.233066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.180692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:25.233096Z","caller":"traceutil/trace.go:171","msg":"trace[1292714396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"194.241684ms","start":"2026-02-10T18:53:25.038847Z","end":"2026-02-10T18:53:25.233088Z","steps":["trace[1292714396] 'agreement among raft nodes before linearized reading'  (duration: 194.197203ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:25.233318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.343506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8hpcf\" ","response":"range_response_count:1 size:10928"}
{"level":"info","ts":"2026-02-10T18:53:25.233975Z","caller":"traceutil/trace.go:171","msg":"trace[966121390] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8hpcf; range_end:; response_count:1; response_revision:967; }","duration":"352.406807ms","start":"2026-02-10T18:53:24.880936Z","end":"2026-02-10T18:53:25.233343Z","steps":["trace[966121390] 'agreement among raft nodes before linearized reading'  (duration: 352.282494ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:25.23408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:24.880924Z","time spent":"353.146746ms","remote":"127.0.0.1:51046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":10951,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8hpcf\" "}
{"level":"info","ts":"2026-02-10T18:53:25.409007Z","caller":"traceutil/trace.go:171","msg":"trace[1784459440] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"165.653805ms","start":"2026-02-10T18:53:25.243255Z","end":"2026-02-10T18:53:25.408909Z","steps":["trace[1784459440] 'process raft request'  (duration: 90.514503ms)","trace[1784459440] 'compare'  (duration: 74.941867ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:25.409332Z","caller":"traceutil/trace.go:171","msg":"trace[233472697] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"162.874638ms","start":"2026-02-10T18:53:25.246453Z","end":"2026-02-10T18:53:25.409328Z","steps":["trace[233472697] 'process raft request'  (duration: 162.663893ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:25.409289Z","caller":"traceutil/trace.go:171","msg":"trace[1394097287] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"164.2567ms","start":"2026-02-10T18:53:25.245016Z","end":"2026-02-10T18:53:25.409273Z","steps":["trace[1394097287] 'process raft request'  (duration: 163.84125ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:31.018753Z","caller":"traceutil/trace.go:171","msg":"trace[525798843] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"110.566646ms","start":"2026-02-10T18:53:30.90816Z","end":"2026-02-10T18:53:31.018727Z","steps":["trace[525798843] 'read index received'  (duration: 110.409862ms)","trace[525798843] 'applied index is now lower than readState.Index'  (duration: 156.004µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:53:31.018869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.684429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:31.018906Z","caller":"traceutil/trace.go:171","msg":"trace[1896006296] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:997; }","duration":"110.772581ms","start":"2026-02-10T18:53:30.908123Z","end":"2026-02-10T18:53:31.018895Z","steps":["trace[1896006296] 'agreement among raft nodes before linearized reading'  (duration: 110.693749ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:31.018964Z","caller":"traceutil/trace.go:171","msg":"trace[261695145] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"132.418383ms","start":"2026-02-10T18:53:30.886525Z","end":"2026-02-10T18:53:31.018944Z","steps":["trace[261695145] 'process raft request'  (duration: 132.057304ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:36.131422Z","caller":"traceutil/trace.go:171","msg":"trace[1751010974] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"109.341857ms","start":"2026-02-10T18:53:36.022057Z","end":"2026-02-10T18:53:36.131399Z","steps":["trace[1751010974] 'process raft request'  (duration: 109.198963ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:40.544027Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813194228,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T18:53:41.044554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813194228,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T18:53:41.171554Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.587526009s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-10T18:53:41.173939Z","caller":"traceutil/trace.go:171","msg":"trace[1054082075] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"1.608401472s","start":"2026-02-10T18:53:39.565509Z","end":"2026-02-10T18:53:41.173911Z","steps":["trace[1054082075] 'process raft request'  (duration: 1.608261689s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.174071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:39.565333Z","time spent":"1.608645769s","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1050 > 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-02-10T18:53:41.174855Z","caller":"traceutil/trace.go:171","msg":"trace[363989541] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1098; }","duration":"1.131655148s","start":"2026-02-10T18:53:40.043187Z","end":"2026-02-10T18:53:41.174842Z","steps":["trace[363989541] 'read index received'  (duration: 1.130784997s)","trace[363989541] 'applied index is now lower than readState.Index'  (duration: 869.211µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:53:41.175115Z","caller":"traceutil/trace.go:171","msg":"trace[277528376] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"133.635812ms","start":"2026-02-10T18:53:41.041468Z","end":"2026-02-10T18:53:41.175104Z","steps":["trace[277528376] 'process raft request'  (duration: 133.309254ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.175266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.132069617s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:41.175299Z","caller":"traceutil/trace.go:171","msg":"trace[696488140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"1.132130379s","start":"2026-02-10T18:53:40.043157Z","end":"2026-02-10T18:53:41.175288Z","steps":["trace[696488140] 'agreement among raft nodes before linearized reading'  (duration: 1.132076448s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.175694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.043146Z","time spent":"1.132534289s","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-10T18:53:41.175961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010128577s","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-02-10T18:53:41.175993Z","caller":"traceutil/trace.go:171","msg":"trace[620186171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"1.010193039s","start":"2026-02-10T18:53:40.165788Z","end":"2026-02-10T18:53:41.175981Z","steps":["trace[620186171] 'agreement among raft nodes before linearized reading'  (duration: 1.010080476s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.17602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.165773Z","time spent":"1.01024076s","remote":"127.0.0.1:51126","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-02-10T18:53:41.176229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.483559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-10T18:53:41.176226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.648128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-02-10T18:53:41.17626Z","caller":"traceutil/trace.go:171","msg":"trace[799369244] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1059; }","duration":"218.517379ms","start":"2026-02-10T18:53:40.957734Z","end":"2026-02-10T18:53:41.176251Z","steps":["trace[799369244] 'agreement among raft nodes before linearized reading'  (duration: 218.455178ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T18:53:41.176299Z","caller":"traceutil/trace.go:171","msg":"trace[490702429] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1059; }","duration":"166.75206ms","start":"2026-02-10T18:53:41.009526Z","end":"2026-02-10T18:53:41.176278Z","steps":["trace[490702429] 'agreement among raft nodes before linearized reading'  (duration: 166.537135ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.176416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.161311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T18:53:41.17645Z","caller":"traceutil/trace.go:171","msg":"trace[399724105] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1059; }","duration":"493.224913ms","start":"2026-02-10T18:53:40.683212Z","end":"2026-02-10T18:53:41.176437Z","steps":["trace[399724105] 'agreement among raft nodes before linearized reading'  (duration: 493.175522ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.176476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.68319Z","time spent":"493.278804ms","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-10T18:53:41.176647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.951908ms","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-02-10T18:53:41.176672Z","caller":"traceutil/trace.go:171","msg":"trace[2068508036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"846.002459ms","start":"2026-02-10T18:53:40.330662Z","end":"2026-02-10T18:53:41.176665Z","steps":["trace[2068508036] 'agreement among raft nodes before linearized reading'  (duration: 845.924978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.176698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.330649Z","time spent":"846.04174ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T18:53:41.176822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.85853ms","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-02-10T18:53:41.17685Z","caller":"traceutil/trace.go:171","msg":"trace[1117450201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1059; }","duration":"902.904332ms","start":"2026-02-10T18:53:40.273937Z","end":"2026-02-10T18:53:41.176842Z","steps":["trace[1117450201] 'agreement among raft nodes before linearized reading'  (duration: 902.82218ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.17688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.27391Z","time spent":"902.963872ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:53:41.176984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.054679ms","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-02-10T18:53:41.177007Z","caller":"traceutil/trace.go:171","msg":"trace[396144626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"904.1204ms","start":"2026-02-10T18:53:40.272879Z","end":"2026-02-10T18:53:41.176999Z","steps":["trace[396144626] 'agreement among raft nodes before linearized reading'  (duration: 904.055909ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:53:41.17703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:53:40.272864Z","time spent":"904.160542ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-10T18:56:46.682111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.641064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6890116316813196257 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1836 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T18:56:46.682173Z","caller":"traceutil/trace.go:171","msg":"trace[741565722] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"168.740769ms","start":"2026-02-10T18:56:46.513422Z","end":"2026-02-10T18:56:46.682163Z","steps":["trace[741565722] 'read index received'  (duration: 31.007894ms)","trace[741565722] 'applied index is now lower than readState.Index'  (duration: 137.732335ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T18:56:46.682321Z","caller":"traceutil/trace.go:171","msg":"trace[2087089808] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"170.827248ms","start":"2026-02-10T18:56:46.511487Z","end":"2026-02-10T18:56:46.682314Z","steps":["trace[2087089808] 'process raft request'  (duration: 32.929818ms)","trace[2087089808] 'compare'  (duration: 137.537541ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:56:46.682456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.038696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-10T18:56:46.682475Z","caller":"traceutil/trace.go:171","msg":"trace[1126036951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1843; }","duration":"169.150478ms","start":"2026-02-10T18:56:46.513317Z","end":"2026-02-10T18:56:46.682467Z","steps":["trace[1126036951] 'agreement among raft nodes before linearized reading'  (duration: 169.087857ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:46.682571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.040973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-02-10T18:56:46.682584Z","caller":"traceutil/trace.go:171","msg":"trace[612323541] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1843; }","duration":"108.077823ms","start":"2026-02-10T18:56:46.574502Z","end":"2026-02-10T18:56:46.68258Z","steps":["trace[612323541] 'agreement among raft nodes before linearized reading'  (duration: 108.040352ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:54.858901Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116316813196351,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T18:56:54.978279Z","caller":"traceutil/trace.go:171","msg":"trace[1667266943] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"622.119975ms","start":"2026-02-10T18:56:54.356129Z","end":"2026-02-10T18:56:54.978249Z","steps":["trace[1667266943] 'process raft request'  (duration: 621.971522ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:54.978457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.356118Z","time spent":"622.251159ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1868 > 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-02-10T18:56:54.979061Z","caller":"traceutil/trace.go:171","msg":"trace[945262699] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1959; }","duration":"620.534779ms","start":"2026-02-10T18:56:54.358504Z","end":"2026-02-10T18:56:54.979039Z","steps":["trace[945262699] 'read index received'  (duration: 620.524968ms)","trace[945262699] 'applied index is now lower than readState.Index'  (duration: 8.001µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T18:56:54.979311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.792785ms","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-02-10T18:56:54.979371Z","caller":"traceutil/trace.go:171","msg":"trace[510998674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1879; }","duration":"620.848756ms","start":"2026-02-10T18:56:54.358502Z","end":"2026-02-10T18:56:54.97935Z","steps":["trace[510998674] 'agreement among raft nodes before linearized reading'  (duration: 620.656341ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:54.979414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.358481Z","time spent":"620.921687ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-10T18:56:55.045204Z","caller":"traceutil/trace.go:171","msg":"trace[559213923] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"125.93073ms","start":"2026-02-10T18:56:54.919257Z","end":"2026-02-10T18:56:55.045188Z","steps":["trace[559213923] 'process raft request'  (duration: 125.851748ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:55.045313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.558495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-02-10T18:56:55.045344Z","caller":"traceutil/trace.go:171","msg":"trace[1455178720] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1880; }","duration":"631.615527ms","start":"2026-02-10T18:56:54.413719Z","end":"2026-02-10T18:56:55.045335Z","steps":["trace[1455178720] 'agreement among raft nodes before linearized reading'  (duration: 631.484034ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:55.045379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.413711Z","time spent":"631.661808ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-10T18:56:55.04546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.687031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-02-10T18:56:55.045475Z","caller":"traceutil/trace.go:171","msg":"trace[999171060] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1880; }","duration":"315.712962ms","start":"2026-02-10T18:56:54.729757Z","end":"2026-02-10T18:56:55.04547Z","steps":["trace[999171060] 'agreement among raft nodes before linearized reading'  (duration: 315.66527ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:55.04549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.729751Z","time spent":"315.734523ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-02-10T18:56:55.045583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.574595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-10T18:56:55.045599Z","caller":"traceutil/trace.go:171","msg":"trace[1951356474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1880; }","duration":"320.611316ms","start":"2026-02-10T18:56:54.724982Z","end":"2026-02-10T18:56:55.045594Z","steps":["trace[1951356474] 'agreement among raft nodes before linearized reading'  (duration: 320.565045ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:55.045613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.724972Z","time spent":"320.637467ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T18:56:55.045661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.049294ms","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-02-10T18:56:55.04568Z","caller":"traceutil/trace.go:171","msg":"trace[434786024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1880; }","duration":"323.104784ms","start":"2026-02-10T18:56:54.72257Z","end":"2026-02-10T18:56:55.045675Z","steps":["trace[434786024] 'agreement among raft nodes before linearized reading'  (duration: 323.047833ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:55.045694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.722553Z","time spent":"323.137876ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T18:56:55.045698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.96248ms","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-02-10T18:56:55.045712Z","caller":"traceutil/trace.go:171","msg":"trace[666616871] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1880; }","duration":"451.002781ms","start":"2026-02-10T18:56:54.594705Z","end":"2026-02-10T18:56:55.045707Z","steps":["trace[666616871] 'agreement among raft nodes before linearized reading'  (duration: 450.96126ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T18:56:55.045726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:56:54.59469Z","time spent":"451.032101ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-10T18:56:55.097961Z","caller":"traceutil/trace.go:171","msg":"trace[286564294] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"114.124555ms","start":"2026-02-10T18:56:54.983819Z","end":"2026-02-10T18:56:55.097944Z","steps":["trace[286564294] 'process raft request'  (duration: 90.817331ms)","trace[286564294] 'compare'  (duration: 23.250182ms)"],"step_count":2}