{"level":"warn","ts":"2026-03-20T05:31:35.192962Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T05:31:35.193045Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-20T05:31:35.193107Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T05:31:35.193119Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]}
{"level":"info","ts":"2026-03-20T05:31:35.193134Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-20T05:31:35.193776Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]}
{"level":"info","ts":"2026-03-20T05:31:35.193848Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-20T05:31:35.199901Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.852011ms"}
{"level":"info","ts":"2026-03-20T05:31:35.204747Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"}
{"level":"info","ts":"2026-03-20T05:31:35.204806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T05:31:35.204821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"}
{"level":"info","ts":"2026-03-20T05:31:35.205401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T05:31:35.205419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"}
{"level":"info","ts":"2026-03-20T05:31:35.205539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"}
{"level":"warn","ts":"2026-03-20T05:31:35.21192Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T05:31:35.213262Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T05:31:35.214994Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-20T05:31:35.216873Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T05:31:35.216979Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T05:31:35.217989Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-20T05:31:35.21805Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-20T05:31:35.218157Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-20T05:31:35.219015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"}
{"level":"info","ts":"2026-03-20T05:31:35.21912Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]}
{"level":"info","ts":"2026-03-20T05:31:35.22076Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-20T05:31:35.220938Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"}
{"level":"info","ts":"2026-03-20T05:31:35.220986Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"}
{"level":"info","ts":"2026-03-20T05:31:35.221731Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T05:31:35.221689Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T05:31:36.206667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T05:31:36.206733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T05:31:36.206751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"}
{"level":"info","ts":"2026-03-20T05:31:36.206774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"}
{"level":"info","ts":"2026-03-20T05:31:36.206787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"}
{"level":"info","ts":"2026-03-20T05:31:36.206804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"}
{"level":"info","ts":"2026-03-20T05:31:36.206818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"}
{"level":"info","ts":"2026-03-20T05:31:36.207673Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T05:31:36.207706Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T05:31:36.207677Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T05:31:36.207776Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:31:36.208023Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T05:31:36.208094Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T05:31:36.208611Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:31:36.208731Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:31:36.208767Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:31:36.21153Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-20T05:31:36.211548Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"}
{"level":"warn","ts":"2026-03-20T05:32:03.518651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.935291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:03.518743Z","caller":"traceutil/trace.go:171","msg":"trace[1870498846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"110.097235ms","start":"2026-03-20T05:32:03.408631Z","end":"2026-03-20T05:32:03.518728Z","steps":["trace[1870498846] 'range keys from in-memory index tree'  (duration: 109.800129ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:05.106816Z","caller":"traceutil/trace.go:171","msg":"trace[334833227] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:519; }","duration":"342.127621ms","start":"2026-03-20T05:32:04.764662Z","end":"2026-03-20T05:32:05.10679Z","steps":["trace[334833227] 'read index received'  (duration: 341.927047ms)","trace[334833227] 'applied index is now lower than readState.Index'  (duration: 199.294µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:05.106951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.262294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:32:05.10699Z","caller":"traceutil/trace.go:171","msg":"trace[1135035776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:506; }","duration":"342.360416ms","start":"2026-03-20T05:32:04.76462Z","end":"2026-03-20T05:32:05.10698Z","steps":["trace[1135035776] 'agreement among raft nodes before linearized reading'  (duration: 342.267534ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:05.10703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:04.764601Z","time spent":"342.421958ms","remote":"127.0.0.1:56760","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":"info","ts":"2026-03-20T05:32:05.106874Z","caller":"traceutil/trace.go:171","msg":"trace[1908411659] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"511.388642ms","start":"2026-03-20T05:32:04.595449Z","end":"2026-03-20T05:32:05.106838Z","steps":["trace[1908411659] 'process raft request'  (duration: 511.089035ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:05.108161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:04.595427Z","time spent":"511.72941ms","remote":"127.0.0.1:56700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:405 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-20T05:32:07.301458Z","caller":"traceutil/trace.go:171","msg":"trace[1646632621] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"182.255651ms","start":"2026-03-20T05:32:07.119184Z","end":"2026-03-20T05:32:07.301439Z","steps":["trace[1646632621] 'process raft request'  (duration: 182.121878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:11.460353Z","caller":"traceutil/trace.go:171","msg":"trace[1863001485] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"611.167666ms","start":"2026-03-20T05:32:10.849159Z","end":"2026-03-20T05:32:11.460327Z","steps":["trace[1863001485] 'process raft request'  (duration: 611.012993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:11.460504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:10.84913Z","time spent":"611.302899ms","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-264lt\" mod_revision:498 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-264lt\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-264lt\" > >"}
{"level":"info","ts":"2026-03-20T05:32:11.690492Z","caller":"traceutil/trace.go:171","msg":"trace[485948973] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:538; }","duration":"375.928609ms","start":"2026-03-20T05:32:11.314547Z","end":"2026-03-20T05:32:11.690476Z","steps":["trace[485948973] 'read index received'  (duration: 145.739434ms)","trace[485948973] 'applied index is now lower than readState.Index'  (duration: 230.188475ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:11.690521Z","caller":"traceutil/trace.go:171","msg":"trace[14441812] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"557.495874ms","start":"2026-03-20T05:32:11.133012Z","end":"2026-03-20T05:32:11.690508Z","steps":["trace[14441812] 'process raft request'  (duration: 557.378612ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:11.690652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.080162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:32:11.690676Z","caller":"traceutil/trace.go:171","msg":"trace[1308292918] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"376.178434ms","start":"2026-03-20T05:32:11.314491Z","end":"2026-03-20T05:32:11.690669Z","steps":["trace[1308292918] 'agreement among raft nodes before linearized reading'  (duration: 376.057251ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:11.690693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:11.314472Z","time spent":"376.216844ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T05:32:11.690647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:11.132985Z","time spent":"557.571617ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:464 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-20T05:32:12.144843Z","caller":"traceutil/trace.go:171","msg":"trace[1913939621] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"454.281363ms","start":"2026-03-20T05:32:11.690536Z","end":"2026-03-20T05:32:12.144817Z","steps":["trace[1913939621] 'read index received'  (duration: 454.162691ms)","trace[1913939621] 'applied index is now lower than readState.Index'  (duration: 117.252µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:12.144896Z","caller":"traceutil/trace.go:171","msg":"trace[1135106752] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"578.677468ms","start":"2026-03-20T05:32:11.566187Z","end":"2026-03-20T05:32:12.144864Z","steps":["trace[1135106752] 'process raft request'  (duration: 578.483324ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:12.145088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.085337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:12.145167Z","caller":"traceutil/trace.go:171","msg":"trace[977754702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:526; }","duration":"737.22062ms","start":"2026-03-20T05:32:11.407927Z","end":"2026-03-20T05:32:12.145148Z","steps":["trace[977754702] 'agreement among raft nodes before linearized reading'  (duration: 737.078577ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:12.145225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:11.407904Z","time spent":"737.308801ms","remote":"127.0.0.1:56532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:32:12.145232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:11.566146Z","time spent":"578.923464ms","remote":"127.0.0.1:56700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4745,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:506 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4711 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-20T05:32:12.187913Z","caller":"traceutil/trace.go:171","msg":"trace[717538230] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"493.689386ms","start":"2026-03-20T05:32:11.694201Z","end":"2026-03-20T05:32:12.18789Z","steps":["trace[717538230] 'process raft request'  (duration: 456.36776ms)","trace[717538230] 'compare'  (duration: 37.095641ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:12.18805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:11.694166Z","time spent":"493.804099ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:517 > 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-03-20T05:32:12.18826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.874587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-20T05:32:12.188332Z","caller":"traceutil/trace.go:171","msg":"trace[1055768513] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:527; }","duration":"174.986149ms","start":"2026-03-20T05:32:12.013329Z","end":"2026-03-20T05:32:12.188315Z","steps":["trace[1055768513] 'agreement among raft nodes before linearized reading'  (duration: 174.770504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:12.188182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.349464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T05:32:12.188524Z","caller":"traceutil/trace.go:171","msg":"trace[45420298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"324.881516ms","start":"2026-03-20T05:32:11.863623Z","end":"2026-03-20T05:32:12.188504Z","steps":["trace[45420298] 'agreement among raft nodes before linearized reading'  (duration: 324.17652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:12.189055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:11.863602Z","time spent":"325.002908ms","remote":"127.0.0.1:56760","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-03-20T05:32:13.640084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34367115s","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015077236 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:519 > 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-03-20T05:32:13.640268Z","caller":"traceutil/trace.go:171","msg":"trace[574135758] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:542; }","duration":"1.332672024s","start":"2026-03-20T05:32:12.30758Z","end":"2026-03-20T05:32:13.640252Z","steps":["trace[574135758] 'read index received'  (duration: 47.791ms)","trace[574135758] 'applied index is now lower than readState.Index'  (duration: 1.284880204s)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:13.64035Z","caller":"traceutil/trace.go:171","msg":"trace[368833206] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.447209869s","start":"2026-03-20T05:32:12.193129Z","end":"2026-03-20T05:32:13.640339Z","steps":["trace[368833206] 'process raft request'  (duration: 103.050728ms)","trace[368833206] 'compare'  (duration: 1.343248171s)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:13.640404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:12.193098Z","time spent":"1.44727543s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:519 > 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-03-20T05:32:13.640699Z","caller":"traceutil/trace.go:171","msg":"trace[756775717] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.447387051s","start":"2026-03-20T05:32:12.1933Z","end":"2026-03-20T05:32:13.640687Z","steps":["trace[756775717] 'process raft request'  (duration: 1.44687787s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:13.640758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:12.193274Z","time spent":"1.447457963s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:518 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:32:13.640941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333358509s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:32:13.640968Z","caller":"traceutil/trace.go:171","msg":"trace[1434098875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"1.333385719s","start":"2026-03-20T05:32:12.307573Z","end":"2026-03-20T05:32:13.640959Z","steps":["trace[1434098875] 'agreement among raft nodes before linearized reading'  (duration: 1.333281617s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:13.640997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:12.307502Z","time spent":"1.333486462s","remote":"127.0.0.1:56760","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-03-20T05:32:13.641341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233527392s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:13.641466Z","caller":"traceutil/trace.go:171","msg":"trace[370823368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"1.233718227s","start":"2026-03-20T05:32:12.407717Z","end":"2026-03-20T05:32:13.641436Z","steps":["trace[370823368] 'agreement among raft nodes before linearized reading'  (duration: 1.23341837s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:13.641528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:12.407698Z","time spent":"1.23381792s","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:32:14.149325Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015077240,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:32:14.41897Z","caller":"traceutil/trace.go:171","msg":"trace[924658847] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"773.341718ms","start":"2026-03-20T05:32:13.6456Z","end":"2026-03-20T05:32:14.418941Z","steps":["trace[924658847] 'process raft request'  (duration: 773.162924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:14.419177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:13.645586Z","time spent":"773.490712ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:520 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:32:14.419545Z","caller":"traceutil/trace.go:171","msg":"trace[13188604] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:545; }","duration":"770.707699ms","start":"2026-03-20T05:32:13.648805Z","end":"2026-03-20T05:32:14.419513Z","steps":["trace[13188604] 'read index received'  (duration: 770.694009ms)","trace[13188604] 'applied index is now lower than readState.Index'  (duration: 10.31µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:14.419715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.886343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:14.419749Z","caller":"traceutil/trace.go:171","msg":"trace[92044541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"770.954474ms","start":"2026-03-20T05:32:13.648786Z","end":"2026-03-20T05:32:14.419741Z","steps":["trace[92044541] 'agreement among raft nodes before linearized reading'  (duration: 770.860622ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:14.419779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:13.648777Z","time spent":"770.995885ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:32:14.430985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.869227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:32:14.431031Z","caller":"traceutil/trace.go:171","msg":"trace[1589715632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:530; }","duration":"237.978739ms","start":"2026-03-20T05:32:14.193041Z","end":"2026-03-20T05:32:14.43102Z","steps":["trace[1589715632] 'agreement among raft nodes before linearized reading'  (duration: 237.845496ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:15.844493Z","caller":"traceutil/trace.go:171","msg":"trace[742699631] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"195.899897ms","start":"2026-03-20T05:32:15.648572Z","end":"2026-03-20T05:32:15.844472Z","steps":["trace[742699631] 'process raft request'  (duration: 195.759274ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:15.974996Z","caller":"traceutil/trace.go:171","msg":"trace[202121562] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"326.174014ms","start":"2026-03-20T05:32:15.648793Z","end":"2026-03-20T05:32:15.974967Z","steps":["trace[202121562] 'process raft request'  (duration: 254.009939ms)","trace[202121562] 'compare'  (duration: 71.9267ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:15.97512Z","caller":"traceutil/trace.go:171","msg":"trace[1054203098] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:551; }","duration":"138.039871ms","start":"2026-03-20T05:32:15.837048Z","end":"2026-03-20T05:32:15.975088Z","steps":["trace[1054203098] 'read index received'  (duration: 7.290773ms)","trace[1054203098] 'applied index is now lower than readState.Index'  (duration: 130.746648ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:15.97516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:15.648774Z","time spent":"326.300778ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:529 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:32:15.975196Z","caller":"traceutil/trace.go:171","msg":"trace[411723028] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"135.547296ms","start":"2026-03-20T05:32:15.839623Z","end":"2026-03-20T05:32:15.97517Z","steps":["trace[411723028] 'process raft request'  (duration: 135.29159ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:15.975431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.367009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-264lt\" ","response":"range_response_count:1 size:17247"}
{"level":"info","ts":"2026-03-20T05:32:15.975468Z","caller":"traceutil/trace.go:171","msg":"trace[1481325259] range","detail":"{range_begin:/registry/pods/kube-system/cilium-264lt; range_end:; response_count:1; response_revision:538; }","duration":"138.459032ms","start":"2026-03-20T05:32:15.836997Z","end":"2026-03-20T05:32:15.975456Z","steps":["trace[1481325259] 'agreement among raft nodes before linearized reading'  (duration: 138.212006ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:16.096964Z","caller":"traceutil/trace.go:171","msg":"trace[937528956] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"109.239696ms","start":"2026-03-20T05:32:15.987704Z","end":"2026-03-20T05:32:16.096944Z","steps":["trace[937528956] 'process raft request'  (duration: 108.923189ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:16.67533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.959867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-20T05:32:16.675406Z","caller":"traceutil/trace.go:171","msg":"trace[706864513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:544; }","duration":"233.06756ms","start":"2026-03-20T05:32:16.442311Z","end":"2026-03-20T05:32:16.675378Z","steps":["trace[706864513] 'range keys from in-memory index tree'  (duration: 232.875945ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:16.675404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.534846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:32:16.675478Z","caller":"traceutil/trace.go:171","msg":"trace[990156971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"252.677409ms","start":"2026-03-20T05:32:16.422783Z","end":"2026-03-20T05:32:16.67546Z","steps":["trace[990156971] 'range keys from in-memory index tree'  (duration: 252.445594ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:16.675369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.955429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:16.675586Z","caller":"traceutil/trace.go:171","msg":"trace[1537061674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"267.237625ms","start":"2026-03-20T05:32:16.408334Z","end":"2026-03-20T05:32:16.675572Z","steps":["trace[1537061674] 'range keys from in-memory index tree'  (duration: 266.852506ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:17.653905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.437062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:17.654052Z","caller":"traceutil/trace.go:171","msg":"trace[436862478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"172.660757ms","start":"2026-03-20T05:32:17.481361Z","end":"2026-03-20T05:32:17.654021Z","steps":["trace[436862478] 'range keys from in-memory index tree'  (duration: 172.328549ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:17.664726Z","caller":"traceutil/trace.go:171","msg":"trace[1199179288] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"140.272211ms","start":"2026-03-20T05:32:17.52442Z","end":"2026-03-20T05:32:17.664693Z","steps":["trace[1199179288] 'process raft request'  (duration: 140.119048ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:19.841375Z","caller":"traceutil/trace.go:171","msg":"trace[246732960] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"113.323468ms","start":"2026-03-20T05:32:19.728028Z","end":"2026-03-20T05:32:19.841352Z","steps":["trace[246732960] 'process raft request'  (duration: 113.207625ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:20.70482Z","caller":"traceutil/trace.go:171","msg":"trace[158327276] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"202.522565ms","start":"2026-03-20T05:32:20.502282Z","end":"2026-03-20T05:32:20.704805Z","steps":["trace[158327276] 'read index received'  (duration: 106.250249ms)","trace[158327276] 'applied index is now lower than readState.Index'  (duration: 96.271666ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:20.704937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.641418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-20T05:32:20.704992Z","caller":"traceutil/trace.go:171","msg":"trace[405201187] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:607; }","duration":"202.722419ms","start":"2026-03-20T05:32:20.502261Z","end":"2026-03-20T05:32:20.704984Z","steps":["trace[405201187] 'agreement among raft nodes before linearized reading'  (duration: 202.635057ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:20.704918Z","caller":"traceutil/trace.go:171","msg":"trace[919693949] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"208.860068ms","start":"2026-03-20T05:32:20.496037Z","end":"2026-03-20T05:32:20.704897Z","steps":["trace[919693949] 'process raft request'  (duration: 113.040572ms)","trace[919693949] 'compare'  (duration: 95.575941ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:20.705073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.010388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-03-20T05:32:20.705149Z","caller":"traceutil/trace.go:171","msg":"trace[818009373] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:607; }","duration":"183.12737ms","start":"2026-03-20T05:32:20.522003Z","end":"2026-03-20T05:32:20.705131Z","steps":["trace[818009373] 'agreement among raft nodes before linearized reading'  (duration: 182.933496ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:20.946629Z","caller":"traceutil/trace.go:171","msg":"trace[198238659] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"196.92536ms","start":"2026-03-20T05:32:20.749692Z","end":"2026-03-20T05:32:20.946617Z","steps":["trace[198238659] 'process raft request'  (duration: 196.774496ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:20.946631Z","caller":"traceutil/trace.go:171","msg":"trace[2034257513] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"237.334675ms","start":"2026-03-20T05:32:20.709272Z","end":"2026-03-20T05:32:20.946607Z","steps":["trace[2034257513] 'process raft request'  (duration: 177.564647ms)","trace[2034257513] 'compare'  (duration: 59.466152ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:20.946602Z","caller":"traceutil/trace.go:171","msg":"trace[722422285] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:624; }","duration":"202.652408ms","start":"2026-03-20T05:32:20.743894Z","end":"2026-03-20T05:32:20.946546Z","steps":["trace[722422285] 'read index received'  (duration: 30.003092ms)","trace[722422285] 'applied index is now lower than readState.Index'  (duration: 172.648296ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:20.946764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.853872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:32:20.946803Z","caller":"traceutil/trace.go:171","msg":"trace[1931457960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:610; }","duration":"202.946094ms","start":"2026-03-20T05:32:20.743846Z","end":"2026-03-20T05:32:20.946792Z","steps":["trace[1931457960] 'agreement among raft nodes before linearized reading'  (duration: 202.808131ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:21.033893Z","caller":"traceutil/trace.go:171","msg":"trace[1237296267] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"252.082935ms","start":"2026-03-20T05:32:20.781787Z","end":"2026-03-20T05:32:21.03387Z","steps":["trace[1237296267] 'process raft request'  (duration: 251.84081ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.027097Z","caller":"traceutil/trace.go:171","msg":"trace[1312899405] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.130147829s","start":"2026-03-20T05:32:20.896917Z","end":"2026-03-20T05:32:22.027065Z","steps":["trace[1312899405] 'process raft request'  (duration: 1.129869363s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.027234Z","caller":"traceutil/trace.go:171","msg":"trace[2123655331] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.132522612s","start":"2026-03-20T05:32:20.894688Z","end":"2026-03-20T05:32:22.02721Z","steps":["trace[2123655331] 'process raft request'  (duration: 1.08066808s)","trace[2123655331] 'compare'  (duration: 51.158496ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:22.027359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.894665Z","time spent":"1.132638624s","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":614,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.189e75b90dd53a2b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189e75b90dd53a2b\" value_size:546 lease:3880868169015076287 >> failure:<>"}
{"level":"info","ts":"2026-03-20T05:32:22.027587Z","caller":"traceutil/trace.go:171","msg":"trace[1747084517] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"998.710814ms","start":"2026-03-20T05:32:21.028852Z","end":"2026-03-20T05:32:22.027563Z","steps":["trace[1747084517] 'process raft request'  (duration: 998.277585ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.027604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.896905Z","time spent":"1.130261812s","remote":"127.0.0.1:56700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4693,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:526 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4659 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-20T05:32:22.027732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:21.028826Z","time spent":"998.836528ms","remote":"127.0.0.1:56598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:610 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:188130 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-03-20T05:32:22.027848Z","caller":"traceutil/trace.go:171","msg":"trace[1474547411] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:627; }","duration":"1.08111226s","start":"2026-03-20T05:32:20.946724Z","end":"2026-03-20T05:32:22.027836Z","steps":["trace[1474547411] 'read index received'  (duration: 86.831294ms)","trace[1474547411] 'applied index is now lower than readState.Index'  (duration: 994.279516ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:22.027991Z","caller":"traceutil/trace.go:171","msg":"trace[1092225174] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.077046289s","start":"2026-03-20T05:32:20.950936Z","end":"2026-03-20T05:32:22.027982Z","steps":["trace[1092225174] 'process raft request'  (duration: 1.075958425s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.028059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.950916Z","time spent":"1.077101341s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:591 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:32:22.028356Z","caller":"traceutil/trace.go:171","msg":"trace[1851798010] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"171.097752ms","start":"2026-03-20T05:32:21.857248Z","end":"2026-03-20T05:32:22.028346Z","steps":["trace[1851798010] 'process raft request'  (duration: 170.266933ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.028507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244021358s","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:5"}
{"level":"info","ts":"2026-03-20T05:32:22.028547Z","caller":"traceutil/trace.go:171","msg":"trace[592317858] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:616; }","duration":"1.244062039s","start":"2026-03-20T05:32:20.784473Z","end":"2026-03-20T05:32:22.028535Z","steps":["trace[592317858] 'agreement among raft nodes before linearized reading'  (duration: 1.243467486s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.028576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.784461Z","time spent":"1.244106841s","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:32:22.028709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244269154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:22.02874Z","caller":"traceutil/trace.go:171","msg":"trace[1768460221] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:616; }","duration":"1.244313415s","start":"2026-03-20T05:32:20.784419Z","end":"2026-03-20T05:32:22.028732Z","steps":["trace[1768460221] 'agreement among raft nodes before linearized reading'  (duration: 1.243528948s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.028767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.784415Z","time spent":"1.244345177s","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 "}
{"level":"warn","ts":"2026-03-20T05:32:22.028865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.2445156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T05:32:22.028824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105892176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"}
{"level":"info","ts":"2026-03-20T05:32:22.0289Z","caller":"traceutil/trace.go:171","msg":"trace[1160227765] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:616; }","duration":"1.244551031s","start":"2026-03-20T05:32:20.784341Z","end":"2026-03-20T05:32:22.028892Z","steps":["trace[1160227765] 'agreement among raft nodes before linearized reading'  (duration: 1.243613639s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.028928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.784329Z","time spent":"1.244590662s","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "}
{"level":"info","ts":"2026-03-20T05:32:22.028939Z","caller":"traceutil/trace.go:171","msg":"trace[1727772621] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:616; }","duration":"1.106068549s","start":"2026-03-20T05:32:20.92284Z","end":"2026-03-20T05:32:22.028909Z","steps":["trace[1727772621] 'agreement among raft nodes before linearized reading'  (duration: 1.105079906s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.029001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.922828Z","time spent":"1.106161152s","remote":"127.0.0.1:56598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24266,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "}
{"level":"warn","ts":"2026-03-20T05:32:22.029089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.618103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"}
{"level":"warn","ts":"2026-03-20T05:32:22.029213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.086504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:32:22.0293Z","caller":"traceutil/trace.go:171","msg":"trace[1173222413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"155.209746ms","start":"2026-03-20T05:32:21.874069Z","end":"2026-03-20T05:32:22.029279Z","steps":["trace[1173222413] 'agreement among raft nodes before linearized reading'  (duration: 154.992532ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.029685Z","caller":"traceutil/trace.go:171","msg":"trace[1889329413] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:616; }","duration":"906.998221ms","start":"2026-03-20T05:32:21.122235Z","end":"2026-03-20T05:32:22.029233Z","steps":["trace[1889329413] 'agreement among raft nodes before linearized reading'  (duration: 905.861885ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.029772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:21.122215Z","time spent":"907.541954ms","remote":"127.0.0.1:56598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":188517,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-03-20T05:32:22.029806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.265065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:22.029854Z","caller":"traceutil/trace.go:171","msg":"trace[1121663074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"622.361437ms","start":"2026-03-20T05:32:21.407478Z","end":"2026-03-20T05:32:22.029839Z","steps":["trace[1121663074] 'agreement among raft nodes before linearized reading'  (duration: 622.277235ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.029894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:21.407464Z","time spent":"622.423709ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:32:22.030871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.206377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188243"}
{"level":"info","ts":"2026-03-20T05:32:22.030959Z","caller":"traceutil/trace.go:171","msg":"trace[737824670] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:616; }","duration":"544.327099ms","start":"2026-03-20T05:32:21.486606Z","end":"2026-03-20T05:32:22.030933Z","steps":["trace[737824670] 'agreement among raft nodes before linearized reading'  (duration: 543.02869ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.030985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:21.486595Z","time spent":"544.384941ms","remote":"127.0.0.1:56598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188265,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-03-20T05:32:22.032204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143389765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-264lt\" ","response":"range_response_count:1 size:18516"}
{"level":"info","ts":"2026-03-20T05:32:22.032258Z","caller":"traceutil/trace.go:171","msg":"trace[329021886] range","detail":"{range_begin:/registry/pods/kube-system/cilium-264lt; range_end:; response_count:1; response_revision:616; }","duration":"1.143477077s","start":"2026-03-20T05:32:20.888766Z","end":"2026-03-20T05:32:22.032243Z","steps":["trace[329021886] 'agreement among raft nodes before linearized reading'  (duration: 1.13916871s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.032288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:20.888751Z","time spent":"1.143531199s","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18538,"request content":"key:\"/registry/pods/kube-system/cilium-264lt\" "}
{"level":"info","ts":"2026-03-20T05:32:22.221039Z","caller":"traceutil/trace.go:171","msg":"trace[1721077022] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"185.975715ms","start":"2026-03-20T05:32:22.035041Z","end":"2026-03-20T05:32:22.221017Z","steps":["trace[1721077022] 'process raft request'  (duration: 185.542735ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.221305Z","caller":"traceutil/trace.go:171","msg":"trace[1920977086] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"182.078957ms","start":"2026-03-20T05:32:22.039218Z","end":"2026-03-20T05:32:22.221297Z","steps":["trace[1920977086] 'process raft request'  (duration: 181.746759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.221379Z","caller":"traceutil/trace.go:171","msg":"trace[2022236516] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"185.618586ms","start":"2026-03-20T05:32:22.035729Z","end":"2026-03-20T05:32:22.221348Z","steps":["trace[2022236516] 'process raft request'  (duration: 185.153526ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.221692Z","caller":"traceutil/trace.go:171","msg":"trace[1320656416] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"176.988413ms","start":"2026-03-20T05:32:22.044695Z","end":"2026-03-20T05:32:22.221683Z","steps":["trace[1320656416] 'process raft request'  (duration: 176.345759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.222205Z","caller":"traceutil/trace.go:171","msg":"trace[1892493064] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"112.315616ms","start":"2026-03-20T05:32:22.109863Z","end":"2026-03-20T05:32:22.222178Z","steps":["trace[1892493064] 'process raft request'  (duration: 111.498437ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.80311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.755652ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015077395 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" mod_revision:378 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" value_size:3761 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:32:22.803263Z","caller":"traceutil/trace.go:171","msg":"trace[450722219] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"572.569122ms","start":"2026-03-20T05:32:22.230672Z","end":"2026-03-20T05:32:22.803241Z","steps":["trace[450722219] 'process raft request'  (duration: 389.585085ms)","trace[450722219] 'compare'  (duration: 182.451705ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:22.803327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.23065Z","time spent":"572.646153ms","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3820,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" mod_revision:378 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" value_size:3761 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" > >"}
{"level":"info","ts":"2026-03-20T05:32:22.858073Z","caller":"traceutil/trace.go:171","msg":"trace[1663941883] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:639; }","duration":"450.243543ms","start":"2026-03-20T05:32:22.407773Z","end":"2026-03-20T05:32:22.858016Z","steps":["trace[1663941883] 'read index received'  (duration: 212.633982ms)","trace[1663941883] 'applied index is now lower than readState.Index'  (duration: 237.608651ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:22.858102Z","caller":"traceutil/trace.go:171","msg":"trace[1722899433] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"627.250817ms","start":"2026-03-20T05:32:22.230805Z","end":"2026-03-20T05:32:22.858056Z","steps":["trace[1722899433] 'process raft request'  (duration: 627.040022ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:22.858191Z","caller":"traceutil/trace.go:171","msg":"trace[640264240] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"627.308318ms","start":"2026-03-20T05:32:22.230873Z","end":"2026-03-20T05:32:22.858182Z","steps":["trace[640264240] 'process raft request'  (duration: 627.101553ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.858261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.230793Z","time spent":"627.38095ms","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3856,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-67659f764b-lg778\" mod_revision:416 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-67659f764b-lg778\" value_size:3797 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-67659f764b-lg778\" > >"}
{"level":"warn","ts":"2026-03-20T05:32:22.858296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.230864Z","time spent":"627.355409ms","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3856,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-67659f764b-dwcgk\" mod_revision:436 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-67659f764b-dwcgk\" value_size:3797 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-67659f764b-dwcgk\" > >"}
{"level":"warn","ts":"2026-03-20T05:32:22.85839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.590401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:22.85847Z","caller":"traceutil/trace.go:171","msg":"trace[1840766666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"450.733534ms","start":"2026-03-20T05:32:22.407715Z","end":"2026-03-20T05:32:22.858449Z","steps":["trace[1840766666] 'agreement among raft nodes before linearized reading'  (duration: 450.56036ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:22.858527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.407689Z","time spent":"450.829626ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:32:23.358591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015077399,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:32:23.455444Z","caller":"traceutil/trace.go:171","msg":"trace[2128031939] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"597.270905ms","start":"2026-03-20T05:32:22.858145Z","end":"2026-03-20T05:32:23.455416Z","steps":["trace[2128031939] 'read index received'  (duration: 559.761454ms)","trace[2128031939] 'applied index is now lower than readState.Index'  (duration: 37.508171ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:23.455699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.781066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" ","response":"range_response_count:1 size:3835"}
{"level":"info","ts":"2026-03-20T05:32:23.455773Z","caller":"traceutil/trace.go:171","msg":"trace[1883475126] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-fbpf2; range_end:; response_count:1; response_revision:626; }","duration":"643.901259ms","start":"2026-03-20T05:32:22.811851Z","end":"2026-03-20T05:32:23.455752Z","steps":["trace[1883475126] 'agreement among raft nodes before linearized reading'  (duration: 643.651074ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.455767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.765538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:32:23.455797Z","caller":"traceutil/trace.go:171","msg":"trace[1784235984] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"644.455282ms","start":"2026-03-20T05:32:22.811315Z","end":"2026-03-20T05:32:23.45577Z","steps":["trace[1784235984] 'process raft request'  (duration: 606.649284ms)","trace[1784235984] 'compare'  (duration: 37.315477ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:23.455842Z","caller":"traceutil/trace.go:171","msg":"trace[1941135458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"677.902611ms","start":"2026-03-20T05:32:22.777922Z","end":"2026-03-20T05:32:23.455824Z","steps":["trace[1941135458] 'agreement among raft nodes before linearized reading'  (duration: 677.662015ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.455925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.811286Z","time spent":"644.573855ms","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b-fbpf2.189e75b97fdfc213\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b-fbpf2.189e75b97fdfc213\" value_size:631 lease:3880868169015076287 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T05:32:23.456034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.056708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"info","ts":"2026-03-20T05:32:23.4561Z","caller":"traceutil/trace.go:171","msg":"trace[491584281] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:626; }","duration":"358.157221ms","start":"2026-03-20T05:32:23.097927Z","end":"2026-03-20T05:32:23.456084Z","steps":["trace[491584281] 'agreement among raft nodes before linearized reading'  (duration: 358.042358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.456104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.271195ms","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-03-20T05:32:23.456112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.221732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"warn","ts":"2026-03-20T05:32:23.455815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.811835Z","time spent":"643.971961ms","remote":"127.0.0.1:56702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":3857,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-fbpf2\" "}
{"level":"warn","ts":"2026-03-20T05:32:23.456152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:23.09792Z","time spent":"358.219902ms","remote":"127.0.0.1:56724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":201,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"warn","ts":"2026-03-20T05:32:23.456153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.03569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-264lt.189e75b913fa7352\" ","response":"range_response_count:1 size:795"}
{"level":"info","ts":"2026-03-20T05:32:23.456161Z","caller":"traceutil/trace.go:171","msg":"trace[1202498127] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:626; }","duration":"358.296044ms","start":"2026-03-20T05:32:23.097855Z","end":"2026-03-20T05:32:23.456151Z","steps":["trace[1202498127] 'agreement among raft nodes before linearized reading'  (duration: 358.211082ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.456163Z","caller":"traceutil/trace.go:171","msg":"trace[118806962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"505.368457ms","start":"2026-03-20T05:32:22.950778Z","end":"2026-03-20T05:32:23.456147Z","steps":["trace[118806962] 'agreement among raft nodes before linearized reading'  (duration: 505.185043ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.456205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:23.097841Z","time spent":"358.356885ms","remote":"127.0.0.1:56724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":201,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"info","ts":"2026-03-20T05:32:23.456206Z","caller":"traceutil/trace.go:171","msg":"trace[673006842] range","detail":"{range_begin:/registry/events/kube-system/cilium-264lt.189e75b913fa7352; range_end:; response_count:1; response_revision:626; }","duration":"459.110261ms","start":"2026-03-20T05:32:22.997082Z","end":"2026-03-20T05:32:23.456192Z","steps":["trace[673006842] 'agreement among raft nodes before linearized reading'  (duration: 459.013729ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.456218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.950753Z","time spent":"505.453998ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T05:32:23.456256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.997071Z","time spent":"459.173823ms","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":817,"request content":"key:\"/registry/events/kube-system/cilium-264lt.189e75b913fa7352\" "}
{"level":"warn","ts":"2026-03-20T05:32:23.45593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.777894Z","time spent":"678.001703ms","remote":"127.0.0.1:56760","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-03-20T05:32:23.456338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.781363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:23.456365Z","caller":"traceutil/trace.go:171","msg":"trace[517528927] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:626; }","duration":"132.825284ms","start":"2026-03-20T05:32:23.323532Z","end":"2026-03-20T05:32:23.456357Z","steps":["trace[517528927] 'agreement among raft nodes before linearized reading'  (duration: 132.782653ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.456271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.642719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T05:32:23.456391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.004935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"info","ts":"2026-03-20T05:32:23.456474Z","caller":"traceutil/trace.go:171","msg":"trace[223392716] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:626; }","duration":"357.123497ms","start":"2026-03-20T05:32:23.099331Z","end":"2026-03-20T05:32:23.456455Z","steps":["trace[223392716] 'agreement among raft nodes before linearized reading'  (duration: 356.934953ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.456523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:23.099321Z","time spent":"357.193838ms","remote":"127.0.0.1:56724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":201,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"info","ts":"2026-03-20T05:32:23.456575Z","caller":"traceutil/trace.go:171","msg":"trace[1209491859] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:626; }","duration":"132.942276ms","start":"2026-03-20T05:32:23.3235Z","end":"2026-03-20T05:32:23.456443Z","steps":["trace[1209491859] 'agreement among raft nodes before linearized reading'  (duration: 132.508257ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.456816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.882271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-03-20T05:32:23.456894Z","caller":"traceutil/trace.go:171","msg":"trace[1415164747] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:626; }","duration":"971.008864ms","start":"2026-03-20T05:32:22.485863Z","end":"2026-03-20T05:32:23.456871Z","steps":["trace[1415164747] 'agreement among raft nodes before linearized reading'  (duration: 970.601005ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.458448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:22.485839Z","time spent":"972.308804ms","remote":"127.0.0.1:56598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188274,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "}
{"level":"info","ts":"2026-03-20T05:32:23.700901Z","caller":"traceutil/trace.go:171","msg":"trace[894857631] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"235.395751ms","start":"2026-03-20T05:32:23.465481Z","end":"2026-03-20T05:32:23.700877Z","steps":["trace[894857631] 'process raft request'  (duration: 235.3391ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.700975Z","caller":"traceutil/trace.go:171","msg":"trace[955797384] transaction","detail":"{read_only:false; number_of_response:0; response_revision:631; }","duration":"235.828301ms","start":"2026-03-20T05:32:23.465124Z","end":"2026-03-20T05:32:23.700952Z","steps":["trace[955797384] 'process raft request'  (duration: 235.673277ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.701124Z","caller":"traceutil/trace.go:171","msg":"trace[1872408704] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"238.201474ms","start":"2026-03-20T05:32:23.46289Z","end":"2026-03-20T05:32:23.701092Z","steps":["trace[1872408704] 'process raft request'  (duration: 237.807075ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.701124Z","caller":"traceutil/trace.go:171","msg":"trace[1610921249] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"239.690087ms","start":"2026-03-20T05:32:23.461395Z","end":"2026-03-20T05:32:23.701085Z","steps":["trace[1610921249] 'process raft request'  (duration: 238.976041ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.701135Z","caller":"traceutil/trace.go:171","msg":"trace[1695080588] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"236.177809ms","start":"2026-03-20T05:32:23.464919Z","end":"2026-03-20T05:32:23.701097Z","steps":["trace[1695080588] 'process raft request'  (duration: 235.832621ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.701159Z","caller":"traceutil/trace.go:171","msg":"trace[568530895] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"239.053293ms","start":"2026-03-20T05:32:23.46204Z","end":"2026-03-20T05:32:23.701093Z","steps":["trace[568530895] 'process raft request'  (duration: 238.579593ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.919712Z","caller":"traceutil/trace.go:171","msg":"trace[1272846472] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"207.896037ms","start":"2026-03-20T05:32:23.711792Z","end":"2026-03-20T05:32:23.919688Z","steps":["trace[1272846472] 'read index received'  (duration: 207.748143ms)","trace[1272846472] 'applied index is now lower than readState.Index'  (duration: 146.974µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:23.919754Z","caller":"traceutil/trace.go:171","msg":"trace[169651640] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"213.41465ms","start":"2026-03-20T05:32:23.706307Z","end":"2026-03-20T05:32:23.919722Z","steps":["trace[169651640] 'process raft request'  (duration: 213.256265ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:23.919942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.126632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1668"}
{"level":"info","ts":"2026-03-20T05:32:23.920003Z","caller":"traceutil/trace.go:171","msg":"trace[91318686] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:633; }","duration":"208.223014ms","start":"2026-03-20T05:32:23.711766Z","end":"2026-03-20T05:32:23.919989Z","steps":["trace[91318686] 'agreement among raft nodes before linearized reading'  (duration: 208.007909ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:23.927014Z","caller":"traceutil/trace.go:171","msg":"trace[235060519] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"214.569995ms","start":"2026-03-20T05:32:23.712422Z","end":"2026-03-20T05:32:23.926992Z","steps":["trace[235060519] 'process raft request'  (duration: 214.405021ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:27.223481Z","caller":"traceutil/trace.go:171","msg":"trace[930782077] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"224.951968ms","start":"2026-03-20T05:32:26.998512Z","end":"2026-03-20T05:32:27.223464Z","steps":["trace[930782077] 'read index received'  (duration: 135.28505ms)","trace[930782077] 'applied index is now lower than readState.Index'  (duration: 89.666128ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:27.223514Z","caller":"traceutil/trace.go:171","msg":"trace[1269721749] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"260.488493ms","start":"2026-03-20T05:32:26.963012Z","end":"2026-03-20T05:32:27.223501Z","steps":["trace[1269721749] 'process raft request'  (duration: 170.876896ms)","trace[1269721749] 'compare'  (duration: 89.400112ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:27.223586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.06416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-264lt\" ","response":"range_response_count:1 size:18713"}
{"level":"info","ts":"2026-03-20T05:32:27.223608Z","caller":"traceutil/trace.go:171","msg":"trace[713376649] range","detail":"{range_begin:/registry/pods/kube-system/cilium-264lt; range_end:; response_count:1; response_revision:659; }","duration":"225.121851ms","start":"2026-03-20T05:32:26.99848Z","end":"2026-03-20T05:32:27.223602Z","steps":["trace[713376649] 'agreement among raft nodes before linearized reading'  (duration: 225.046319ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:27.429868Z","caller":"traceutil/trace.go:171","msg":"trace[1504368430] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"193.494314ms","start":"2026-03-20T05:32:27.236357Z","end":"2026-03-20T05:32:27.429851Z","steps":["trace[1504368430] 'process raft request'  (duration: 193.293829ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:27.555056Z","caller":"traceutil/trace.go:171","msg":"trace[1107103435] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:678; }","duration":"147.046033ms","start":"2026-03-20T05:32:27.407989Z","end":"2026-03-20T05:32:27.555035Z","steps":["trace[1107103435] 'read index received'  (duration: 21.693585ms)","trace[1107103435] 'applied index is now lower than readState.Index'  (duration: 125.351527ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:27.55509Z","caller":"traceutil/trace.go:171","msg":"trace[305428311] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"195.051397ms","start":"2026-03-20T05:32:27.360014Z","end":"2026-03-20T05:32:27.555065Z","steps":["trace[305428311] 'process raft request'  (duration: 131.33919ms)","trace[305428311] 'compare'  (duration: 63.583354ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:27.555204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.205436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:27.555263Z","caller":"traceutil/trace.go:171","msg":"trace[1692026589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:661; }","duration":"147.306928ms","start":"2026-03-20T05:32:27.407942Z","end":"2026-03-20T05:32:27.555249Z","steps":["trace[1692026589] 'agreement among raft nodes before linearized reading'  (duration: 147.166525ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:27.555287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.969749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-264lt\" ","response":"range_response_count:1 size:18713"}
{"level":"info","ts":"2026-03-20T05:32:27.555326Z","caller":"traceutil/trace.go:171","msg":"trace[2076261408] range","detail":"{range_begin:/registry/pods/kube-system/cilium-264lt; range_end:; response_count:1; response_revision:661; }","duration":"121.043351ms","start":"2026-03-20T05:32:27.434273Z","end":"2026-03-20T05:32:27.555316Z","steps":["trace[2076261408] 'agreement among raft nodes before linearized reading'  (duration: 120.881527ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:27.703998Z","caller":"traceutil/trace.go:171","msg":"trace[80673064] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"138.43648ms","start":"2026-03-20T05:32:27.565533Z","end":"2026-03-20T05:32:27.70397Z","steps":["trace[80673064] 'process raft request'  (duration: 120.599291ms)","trace[80673064] 'compare'  (duration: 17.712146ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:27.825014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.568822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:32:27.825068Z","caller":"traceutil/trace.go:171","msg":"trace[1038170721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:666; }","duration":"108.641273ms","start":"2026-03-20T05:32:27.716415Z","end":"2026-03-20T05:32:27.825056Z","steps":["trace[1038170721] 'agreement among raft nodes before linearized reading'  (duration: 108.50147ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.039967Z","caller":"traceutil/trace.go:171","msg":"trace[2096664247] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"125.736116ms","start":"2026-03-20T05:32:27.914209Z","end":"2026-03-20T05:32:28.039945Z","steps":["trace[2096664247] 'process raft request'  (duration: 125.592333ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.300739Z","caller":"traceutil/trace.go:171","msg":"trace[1918004030] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:688; }","duration":"248.691328ms","start":"2026-03-20T05:32:28.052028Z","end":"2026-03-20T05:32:28.30072Z","steps":["trace[1918004030] 'read index received'  (duration: 54.207263ms)","trace[1918004030] 'applied index is now lower than readState.Index'  (duration: 194.483415ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:28.300831Z","caller":"traceutil/trace.go:171","msg":"trace[876433139] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"253.393255ms","start":"2026-03-20T05:32:28.04743Z","end":"2026-03-20T05:32:28.300823Z","steps":["trace[876433139] 'process raft request'  (duration: 222.296798ms)","trace[876433139] 'compare'  (duration: 30.81524ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:28.301175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.130999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-20T05:32:28.301208Z","caller":"traceutil/trace.go:171","msg":"trace[1758057578] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:672; }","duration":"249.189341ms","start":"2026-03-20T05:32:28.05201Z","end":"2026-03-20T05:32:28.301199Z","steps":["trace[1758057578] 'agreement among raft nodes before linearized reading'  (duration: 249.080569ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:28.301308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.812049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-20T05:32:28.301304Z","caller":"traceutil/trace.go:171","msg":"trace[688428207] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"249.629462ms","start":"2026-03-20T05:32:28.051653Z","end":"2026-03-20T05:32:28.301282Z","steps":["trace[688428207] 'process raft request'  (duration: 249.027267ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.30137Z","caller":"traceutil/trace.go:171","msg":"trace[825589678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:672; }","duration":"146.9107ms","start":"2026-03-20T05:32:28.154445Z","end":"2026-03-20T05:32:28.301355Z","steps":["trace[825589678] 'agreement among raft nodes before linearized reading'  (duration: 146.728956ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.520293Z","caller":"traceutil/trace.go:171","msg":"trace[1122853027] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"214.100725ms","start":"2026-03-20T05:32:28.306162Z","end":"2026-03-20T05:32:28.520262Z","steps":["trace[1122853027] 'process raft request'  (duration: 195.338495ms)","trace[1122853027] 'compare'  (duration: 18.560626ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:28.52032Z","caller":"traceutil/trace.go:171","msg":"trace[543866775] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"213.945122ms","start":"2026-03-20T05:32:28.306354Z","end":"2026-03-20T05:32:28.520299Z","steps":["trace[543866775] 'process raft request'  (duration: 213.83456ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.520399Z","caller":"traceutil/trace.go:171","msg":"trace[1472326952] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"213.083411ms","start":"2026-03-20T05:32:28.307283Z","end":"2026-03-20T05:32:28.520366Z","steps":["trace[1472326952] 'process raft request'  (duration: 212.940358ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.520664Z","caller":"traceutil/trace.go:171","msg":"trace[1173001003] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"212.54449ms","start":"2026-03-20T05:32:28.308094Z","end":"2026-03-20T05:32:28.520638Z","steps":["trace[1173001003] 'process raft request'  (duration: 212.163922ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.520743Z","caller":"traceutil/trace.go:171","msg":"trace[1284350934] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"212.450668ms","start":"2026-03-20T05:32:28.308283Z","end":"2026-03-20T05:32:28.520734Z","steps":["trace[1284350934] 'process raft request'  (duration: 212.188802ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.52085Z","caller":"traceutil/trace.go:171","msg":"trace[1052613172] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"212.029109ms","start":"2026-03-20T05:32:28.308809Z","end":"2026-03-20T05:32:28.520838Z","steps":["trace[1052613172] 'process raft request'  (duration: 211.897606ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.646279Z","caller":"traceutil/trace.go:171","msg":"trace[978786590] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"117.507402ms","start":"2026-03-20T05:32:28.528754Z","end":"2026-03-20T05:32:28.646261Z","steps":["trace[978786590] 'process raft request'  (duration: 116.219443ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.646625Z","caller":"traceutil/trace.go:171","msg":"trace[1914428103] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"117.543852ms","start":"2026-03-20T05:32:28.529049Z","end":"2026-03-20T05:32:28.646593Z","steps":["trace[1914428103] 'process raft request'  (duration: 117.170304ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.646708Z","caller":"traceutil/trace.go:171","msg":"trace[1877821085] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:698; }","duration":"117.766038ms","start":"2026-03-20T05:32:28.528934Z","end":"2026-03-20T05:32:28.6467Z","steps":["trace[1877821085] 'read index received'  (duration: 51.078484ms)","trace[1877821085] 'applied index is now lower than readState.Index'  (duration: 66.686904ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:28.646651Z","caller":"traceutil/trace.go:171","msg":"trace[907578735] transaction","detail":"{read_only:false; number_of_response:1; response_revision:682; }","duration":"117.493031ms","start":"2026-03-20T05:32:28.52914Z","end":"2026-03-20T05:32:28.646633Z","steps":["trace[907578735] 'process raft request'  (duration: 117.295247ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:28.647125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.178937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-dwcgk\" ","response":"range_response_count:1 size:5083"}
{"level":"info","ts":"2026-03-20T05:32:28.647152Z","caller":"traceutil/trace.go:171","msg":"trace[1073747591] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-dwcgk; range_end:; response_count:1; response_revision:682; }","duration":"118.242167ms","start":"2026-03-20T05:32:28.528903Z","end":"2026-03-20T05:32:28.647145Z","steps":["trace[1073747591] 'agreement among raft nodes before linearized reading'  (duration: 117.824988ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:28.867597Z","caller":"traceutil/trace.go:171","msg":"trace[2078686432] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"214.580215ms","start":"2026-03-20T05:32:28.652981Z","end":"2026-03-20T05:32:28.867561Z","steps":["trace[2078686432] 'process raft request'  (duration: 214.157136ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:29.147251Z","caller":"traceutil/trace.go:171","msg":"trace[1927177246] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"493.270887ms","start":"2026-03-20T05:32:28.653955Z","end":"2026-03-20T05:32:29.147226Z","steps":["trace[1927177246] 'process raft request'  (duration: 493.072411ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:29.147402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:28.653893Z","time spent":"493.434221ms","remote":"127.0.0.1:56922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:439 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:4164 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"info","ts":"2026-03-20T05:32:29.147484Z","caller":"traceutil/trace.go:171","msg":"trace[1768691046] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"293.297849ms","start":"2026-03-20T05:32:28.854107Z","end":"2026-03-20T05:32:29.147405Z","steps":["trace[1768691046] 'process raft request'  (duration: 293.066674ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:29.1553Z","caller":"traceutil/trace.go:171","msg":"trace[617477424] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"282.543846ms","start":"2026-03-20T05:32:28.872743Z","end":"2026-03-20T05:32:29.155287Z","steps":["trace[617477424] 'process raft request'  (duration: 282.324321ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:29.155376Z","caller":"traceutil/trace.go:171","msg":"trace[1539220180] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"282.648948ms","start":"2026-03-20T05:32:28.872703Z","end":"2026-03-20T05:32:29.155352Z","steps":["trace[1539220180] 'process raft request'  (duration: 282.327581ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:29.155529Z","caller":"traceutil/trace.go:171","msg":"trace[1460894327] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"283.411088ms","start":"2026-03-20T05:32:28.872093Z","end":"2026-03-20T05:32:29.155504Z","steps":["trace[1460894327] 'process raft request'  (duration: 282.846064ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.549424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141564559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:37.549905Z","caller":"traceutil/trace.go:171","msg":"trace[402333949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"1.142082071s","start":"2026-03-20T05:32:36.407801Z","end":"2026-03-20T05:32:37.549883Z","steps":["trace[402333949] 'range keys from in-memory index tree'  (duration: 1.141495098s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.54996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:36.407792Z","time spent":"1.142153242s","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:32:37.549511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.096805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:32:37.550215Z","caller":"traceutil/trace.go:171","msg":"trace[1504516962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:720; }","duration":"970.839701ms","start":"2026-03-20T05:32:36.579359Z","end":"2026-03-20T05:32:37.550198Z","steps":["trace[1504516962] 'range keys from in-memory index tree'  (duration: 969.934821ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.550266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:36.579344Z","time spent":"970.906183ms","remote":"127.0.0.1:56760","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-03-20T05:32:37.549537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.894761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:32:37.55042Z","caller":"traceutil/trace.go:171","msg":"trace[233293358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:720; }","duration":"970.80324ms","start":"2026-03-20T05:32:36.579583Z","end":"2026-03-20T05:32:37.550386Z","steps":["trace[233293358] 'range keys from in-memory index tree'  (duration: 969.744097ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.549556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.666011ms","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":"warn","ts":"2026-03-20T05:32:37.550478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:36.579564Z","time spent":"970.895463ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T05:32:37.550496Z","caller":"traceutil/trace.go:171","msg":"trace[2130417486] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:720; }","duration":"629.648964ms","start":"2026-03-20T05:32:36.920826Z","end":"2026-03-20T05:32:37.550475Z","steps":["trace[2130417486] 'count revisions from in-memory index tree'  (duration: 628.60619ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.550635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:36.920812Z","time spent":"629.803687ms","remote":"127.0.0.1:56674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:32:37.549642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.172234166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T05:32:37.55069Z","caller":"traceutil/trace.go:171","msg":"trace[844412864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:720; }","duration":"1.173302881s","start":"2026-03-20T05:32:36.377375Z","end":"2026-03-20T05:32:37.550678Z","steps":["trace[844412864] 'range keys from in-memory index tree'  (duration: 1.172113203s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.550901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:36.377361Z","time spent":"1.173499815s","remote":"127.0.0.1:56760","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-03-20T05:32:37.952906Z","caller":"traceutil/trace.go:171","msg":"trace[605180233] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"397.278116ms","start":"2026-03-20T05:32:37.555603Z","end":"2026-03-20T05:32:37.952881Z","steps":["trace[605180233] 'process raft request'  (duration: 397.088222ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:37.953062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:37.555587Z","time spent":"397.396018ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:718 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-20T05:32:38.660697Z","caller":"traceutil/trace.go:171","msg":"trace[767277917] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:742; }","duration":"755.305031ms","start":"2026-03-20T05:32:37.905373Z","end":"2026-03-20T05:32:38.660678Z","steps":["trace[767277917] 'read index received'  (duration: 47.441483ms)","trace[767277917] 'applied index is now lower than readState.Index'  (duration: 707.862748ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:38.660795Z","caller":"traceutil/trace.go:171","msg":"trace[1944931223] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"1.104376346s","start":"2026-03-20T05:32:37.556412Z","end":"2026-03-20T05:32:38.660789Z","steps":["trace[1944931223] 'process raft request'  (duration: 1.104117331s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:38.660912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:37.556393Z","time spent":"1.104422617s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:717 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:32:38.661016Z","caller":"traceutil/trace.go:171","msg":"trace[650112213] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"1.104593171s","start":"2026-03-20T05:32:37.556417Z","end":"2026-03-20T05:32:38.66101Z","steps":["trace[650112213] 'process raft request'  (duration: 1.104230813s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:38.661053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:37.556401Z","time spent":"1.104634572s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:716 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:32:38.661171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.806393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:32:38.661197Z","caller":"traceutil/trace.go:171","msg":"trace[1821637390] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:723; }","duration":"755.864523ms","start":"2026-03-20T05:32:37.905326Z","end":"2026-03-20T05:32:38.66119Z","steps":["trace[1821637390] 'agreement among raft nodes before linearized reading'  (duration: 755.776461ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:38.661217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:37.905307Z","time spent":"755.906015ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T05:32:38.661327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.128918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:32:38.661396Z","caller":"traceutil/trace.go:171","msg":"trace[1442264997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:723; }","duration":"689.236569ms","start":"2026-03-20T05:32:37.972142Z","end":"2026-03-20T05:32:38.661378Z","steps":["trace[1442264997] 'agreement among raft nodes before linearized reading'  (duration: 689.025715ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:38.661446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:37.972114Z","time spent":"689.325072ms","remote":"127.0.0.1:56760","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":"info","ts":"2026-03-20T05:32:38.865172Z","caller":"traceutil/trace.go:171","msg":"trace[1577958426] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"200.081225ms","start":"2026-03-20T05:32:38.665068Z","end":"2026-03-20T05:32:38.865149Z","steps":["trace[1577958426] 'process raft request'  (duration: 177.699153ms)","trace[1577958426] 'compare'  (duration: 22.118215ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:39.777871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.911799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-20T05:32:39.777943Z","caller":"traceutil/trace.go:171","msg":"trace[1588850359] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:725; }","duration":"675.051591ms","start":"2026-03-20T05:32:39.102869Z","end":"2026-03-20T05:32:39.777921Z","steps":["trace[1588850359] 'range keys from in-memory index tree'  (duration: 674.738265ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:39.777988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:39.102841Z","time spent":"675.139664ms","remote":"127.0.0.1:56584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "}
{"level":"warn","ts":"2026-03-20T05:32:39.778189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.935694ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015077602 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:685 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:32:39.778316Z","caller":"traceutil/trace.go:171","msg":"trace[891203071] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"370.902415ms","start":"2026-03-20T05:32:39.407396Z","end":"2026-03-20T05:32:39.778298Z","steps":["trace[891203071] 'read index received'  (duration: 235.668673ms)","trace[891203071] 'applied index is now lower than readState.Index'  (duration: 135.232122ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:39.77834Z","caller":"traceutil/trace.go:171","msg":"trace[1839002817] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"534.45523ms","start":"2026-03-20T05:32:39.243873Z","end":"2026-03-20T05:32:39.778328Z","steps":["trace[1839002817] 'process raft request'  (duration: 399.27648ms)","trace[1839002817] 'compare'  (duration: 134.75282ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:39.778394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.990796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T05:32:39.778434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:39.243834Z","time spent":"534.534192ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:685 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-03-20T05:32:39.778451Z","caller":"traceutil/trace.go:171","msg":"trace[256853837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"371.079239ms","start":"2026-03-20T05:32:39.407356Z","end":"2026-03-20T05:32:39.778435Z","steps":["trace[256853837] 'agreement among raft nodes before linearized reading'  (duration: 370.982967ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:39.778476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:32:39.407341Z","time spent":"371.131ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T05:32:39.94892Z","caller":"traceutil/trace.go:171","msg":"trace[1339972844] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"169.771035ms","start":"2026-03-20T05:32:39.779115Z","end":"2026-03-20T05:32:39.948886Z","steps":["trace[1339972844] 'read index received'  (duration: 134.303991ms)","trace[1339972844] 'applied index is now lower than readState.Index'  (duration: 35.465164ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:39.949083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.942818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:32:39.949192Z","caller":"traceutil/trace.go:171","msg":"trace[78855849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"170.064363ms","start":"2026-03-20T05:32:39.779105Z","end":"2026-03-20T05:32:39.949169Z","steps":["trace[78855849] 'agreement among raft nodes before linearized reading'  (duration: 169.880728ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:50.917952Z","caller":"traceutil/trace.go:171","msg":"trace[329849258] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"203.380609ms","start":"2026-03-20T05:32:50.714548Z","end":"2026-03-20T05:32:50.917928Z","steps":["trace[329849258] 'read index received'  (duration: 203.201345ms)","trace[329849258] 'applied index is now lower than readState.Index'  (duration: 178.374µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:32:50.918147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.940192ms","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-03-20T05:32:50.918202Z","caller":"traceutil/trace.go:171","msg":"trace[1048826012] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:764; }","duration":"171.037624ms","start":"2026-03-20T05:32:50.747151Z","end":"2026-03-20T05:32:50.918189Z","steps":["trace[1048826012] 'agreement among raft nodes before linearized reading'  (duration: 170.932412ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:50.918229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.663385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:32:50.918293Z","caller":"traceutil/trace.go:171","msg":"trace[2143146099] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"203.755378ms","start":"2026-03-20T05:32:50.714523Z","end":"2026-03-20T05:32:50.918278Z","steps":["trace[2143146099] 'agreement among raft nodes before linearized reading'  (duration: 203.535213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:32:50.918476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.845238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:32:50.91853Z","caller":"traceutil/trace.go:171","msg":"trace[246730151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:764; }","duration":"157.94254ms","start":"2026-03-20T05:32:50.760574Z","end":"2026-03-20T05:32:50.918517Z","steps":["trace[246730151] 'agreement among raft nodes before linearized reading'  (duration: 157.818177ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:50.918762Z","caller":"traceutil/trace.go:171","msg":"trace[1436830025] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"206.61578ms","start":"2026-03-20T05:32:50.712129Z","end":"2026-03-20T05:32:50.918744Z","steps":["trace[1436830025] 'process raft request'  (duration: 205.652029ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:51.139237Z","caller":"traceutil/trace.go:171","msg":"trace[1116296731] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"215.90366ms","start":"2026-03-20T05:32:50.923289Z","end":"2026-03-20T05:32:51.139193Z","steps":["trace[1116296731] 'process raft request'  (duration: 166.633135ms)","trace[1116296731] 'compare'  (duration: 49.05131ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:32:51.223961Z","caller":"traceutil/trace.go:171","msg":"trace[304697575] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"299.396142ms","start":"2026-03-20T05:32:50.924542Z","end":"2026-03-20T05:32:51.223938Z","steps":["trace[304697575] 'process raft request'  (duration: 299.226848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:32:51.224124Z","caller":"traceutil/trace.go:171","msg":"trace[327804364] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"299.414792ms","start":"2026-03-20T05:32:50.924678Z","end":"2026-03-20T05:32:51.224093Z","steps":["trace[327804364] 'process raft request'  (duration: 299.225598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:01.34131Z","caller":"traceutil/trace.go:171","msg":"trace[1239543279] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"150.045244ms","start":"2026-03-20T05:33:01.19124Z","end":"2026-03-20T05:33:01.341285Z","steps":["trace[1239543279] 'read index received'  (duration: 149.850239ms)","trace[1239543279] 'applied index is now lower than readState.Index'  (duration: 193.784µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:01.341366Z","caller":"traceutil/trace.go:171","msg":"trace[2011265480] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"301.349495ms","start":"2026-03-20T05:33:01.039995Z","end":"2026-03-20T05:33:01.341345Z","steps":["trace[2011265480] 'process raft request'  (duration: 301.165781ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:01.341509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:01.039975Z","time spent":"301.438047ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:785 > 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":"warn","ts":"2026-03-20T05:33:01.341826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.576606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-20T05:33:01.341887Z","caller":"traceutil/trace.go:171","msg":"trace[1652049872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"150.661317ms","start":"2026-03-20T05:33:01.191211Z","end":"2026-03-20T05:33:01.341872Z","steps":["trace[1652049872] 'agreement among raft nodes before linearized reading'  (duration: 150.212818ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:03.062906Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.612973287s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-20T05:33:03.118438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.66839904s","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015077803 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:789 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:33:03.119532Z","caller":"traceutil/trace.go:171","msg":"trace[1448756662] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"173.894148ms","start":"2026-03-20T05:33:02.945607Z","end":"2026-03-20T05:33:03.119501Z","steps":["trace[1448756662] 'process raft request'  (duration: 173.295014ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:03.120391Z","caller":"traceutil/trace.go:171","msg":"trace[2077487551] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"1.773636709s","start":"2026-03-20T05:33:01.346693Z","end":"2026-03-20T05:33:03.12033Z","steps":["trace[2077487551] 'process raft request'  (duration: 1.772153575s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:03.120403Z","caller":"traceutil/trace.go:171","msg":"trace[632472008] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:819; }","duration":"1.712709273s","start":"2026-03-20T05:33:01.407646Z","end":"2026-03-20T05:33:03.120355Z","steps":["trace[632472008] 'read index received'  (duration: 42.307258ms)","trace[632472008] 'applied index is now lower than readState.Index'  (duration: 1.670341994s)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:03.120685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:01.346676Z","time spent":"1.773846464s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:787 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:03.121577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.71391939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:03.121668Z","caller":"traceutil/trace.go:171","msg":"trace[1201889497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"1.714018543s","start":"2026-03-20T05:33:01.40763Z","end":"2026-03-20T05:33:03.121648Z","steps":["trace[1201889497] 'agreement among raft nodes before linearized reading'  (duration: 1.712832826s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:03.12174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:01.407573Z","time spent":"1.714155675s","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T05:33:03.121579Z","caller":"traceutil/trace.go:171","msg":"trace[1386600808] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"1.775149862s","start":"2026-03-20T05:33:01.346399Z","end":"2026-03-20T05:33:03.121549Z","steps":["trace[1386600808] 'process raft request'  (duration: 1.772146785s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:03.121689Z","caller":"traceutil/trace.go:171","msg":"trace[1482646490] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"1.774676092s","start":"2026-03-20T05:33:01.345687Z","end":"2026-03-20T05:33:03.120363Z","steps":["trace[1482646490] 'process raft request'  (duration: 104.255867ms)","trace[1482646490] 'compare'  (duration: 1.665370272s)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:03.121819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:01.346376Z","time spent":"1.775409358s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:788 > 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-03-20T05:33:03.121884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:01.345671Z","time spent":"1.776152025s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:789 > 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-03-20T05:33:03.123008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.132314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-20T05:33:03.123104Z","caller":"traceutil/trace.go:171","msg":"trace[1325000903] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"849.272667ms","start":"2026-03-20T05:33:02.273818Z","end":"2026-03-20T05:33:03.12309Z","steps":["trace[1325000903] 'agreement among raft nodes before linearized reading'  (duration: 849.097254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:03.123165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:02.273773Z","time spent":"849.38347ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T05:33:05.463123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.062403254s","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015077814 > lease_revoke:<id:35db9d09ba43ab4b>","response":"size:27"}
{"level":"info","ts":"2026-03-20T05:33:05.463199Z","caller":"traceutil/trace.go:171","msg":"trace[1845078775] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"1.055425029s","start":"2026-03-20T05:33:04.407761Z","end":"2026-03-20T05:33:05.463186Z","steps":["trace[1845078775] 'read index received'  (duration: 32.771µs)","trace[1845078775] 'applied index is now lower than readState.Index'  (duration: 1.055391228s)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:05.463429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055660244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:05.463457Z","caller":"traceutil/trace.go:171","msg":"trace[1794135034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"1.055721394s","start":"2026-03-20T05:33:04.407727Z","end":"2026-03-20T05:33:05.463449Z","steps":["trace[1794135034] 'agreement among raft nodes before linearized reading'  (duration: 1.055667173s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.463479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:04.407713Z","time spent":"1.055761446s","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:33:05.46367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.552626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T05:33:05.463687Z","caller":"traceutil/trace.go:171","msg":"trace[1096148887] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:798; }","duration":"830.608648ms","start":"2026-03-20T05:33:04.633073Z","end":"2026-03-20T05:33:05.463682Z","steps":["trace[1096148887] 'agreement among raft nodes before linearized reading'  (duration: 830.526806ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.463703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:04.633053Z","time spent":"830.645729ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":66,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:33:05.463732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.792775ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:05.463818Z","caller":"traceutil/trace.go:171","msg":"trace[1182522577] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:798; }","duration":"384.885707ms","start":"2026-03-20T05:33:05.078917Z","end":"2026-03-20T05:33:05.463803Z","steps":["trace[1182522577] 'range keys from in-memory index tree'  (duration: 384.773494ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.463856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.895891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:33:05.463877Z","caller":"traceutil/trace.go:171","msg":"trace[1841507565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"336.916992ms","start":"2026-03-20T05:33:05.126954Z","end":"2026-03-20T05:33:05.463871Z","steps":["trace[1841507565] 'agreement among raft nodes before linearized reading'  (duration: 336.83633ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.463893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.126891Z","time spent":"336.998033ms","remote":"127.0.0.1:56760","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-03-20T05:33:05.46394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.871081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-20T05:33:05.463944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.600574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T05:33:05.464006Z","caller":"traceutil/trace.go:171","msg":"trace[1499332221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"336.983793ms","start":"2026-03-20T05:33:05.127005Z","end":"2026-03-20T05:33:05.463988Z","steps":["trace[1499332221] 'agreement among raft nodes before linearized reading'  (duration: 336.779229ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.464046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.12698Z","time spent":"337.057885ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-20T05:33:05.464044Z","caller":"traceutil/trace.go:171","msg":"trace[702997728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"100.724867ms","start":"2026-03-20T05:33:05.363292Z","end":"2026-03-20T05:33:05.464017Z","steps":["trace[702997728] 'agreement among raft nodes before linearized reading'  (duration: 100.464591ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.46416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.66119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:33:05.464182Z","caller":"traceutil/trace.go:171","msg":"trace[162809909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"275.707141ms","start":"2026-03-20T05:33:05.188468Z","end":"2026-03-20T05:33:05.464176Z","steps":["trace[162809909] 'agreement among raft nodes before linearized reading'  (duration: 275.646349ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.46421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.942963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:33:05.464233Z","caller":"traceutil/trace.go:171","msg":"trace[1422508805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"336.988675ms","start":"2026-03-20T05:33:05.127236Z","end":"2026-03-20T05:33:05.464225Z","steps":["trace[1422508805] 'agreement among raft nodes before linearized reading'  (duration: 336.889382ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.464252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.127224Z","time spent":"337.023115ms","remote":"127.0.0.1:56760","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":"info","ts":"2026-03-20T05:33:05.856528Z","caller":"traceutil/trace.go:171","msg":"trace[663601835] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"388.484909ms","start":"2026-03-20T05:33:05.468014Z","end":"2026-03-20T05:33:05.856499Z","steps":["trace[663601835] 'process raft request'  (duration: 388.319775ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:05.856804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.467993Z","time spent":"388.614031ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:794 > 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-03-20T05:33:05.999745Z","caller":"traceutil/trace.go:171","msg":"trace[728195228] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:826; }","duration":"526.801689ms","start":"2026-03-20T05:33:05.472921Z","end":"2026-03-20T05:33:05.999723Z","steps":["trace[728195228] 'read index received'  (duration: 383.445716ms)","trace[728195228] 'applied index is now lower than readState.Index'  (duration: 143.354903ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:05.999978Z","caller":"traceutil/trace.go:171","msg":"trace[126637032] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"530.551483ms","start":"2026-03-20T05:33:05.469392Z","end":"2026-03-20T05:33:05.999944Z","steps":["trace[126637032] 'process raft request'  (duration: 530.233356ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:06.000055Z","caller":"traceutil/trace.go:171","msg":"trace[1784956299] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"531.135186ms","start":"2026-03-20T05:33:05.468877Z","end":"2026-03-20T05:33:06.000012Z","steps":["trace[1784956299] 'process raft request'  (duration: 523.256399ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:06.000108Z","caller":"traceutil/trace.go:171","msg":"trace[2030242966] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"530.454931ms","start":"2026-03-20T05:33:05.469618Z","end":"2026-03-20T05:33:06.000073Z","steps":["trace[2030242966] 'process raft request'  (duration: 530.046602ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:06.000158Z","caller":"traceutil/trace.go:171","msg":"trace[1953072230] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"530.341128ms","start":"2026-03-20T05:33:05.469797Z","end":"2026-03-20T05:33:06.000138Z","steps":["trace[1953072230] 'process raft request'  (duration: 529.895998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:06.000233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.923561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T05:33:06.000238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.468863Z","time spent":"531.286559ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:793 > 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":"info","ts":"2026-03-20T05:33:06.000276Z","caller":"traceutil/trace.go:171","msg":"trace[33703696] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"527.364771ms","start":"2026-03-20T05:33:05.4729Z","end":"2026-03-20T05:33:06.000265Z","steps":["trace[33703696] 'agreement among raft nodes before linearized reading'  (duration: 526.908381ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:06.00028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.469613Z","time spent":"530.573324ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:795 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:06.00032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.472892Z","time spent":"527.418872ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:33:06.000349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.469792Z","time spent":"530.45667ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:798 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:06.00041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:05.469385Z","time spent":"530.715227ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:797 > 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-03-20T05:33:14.995127Z","caller":"traceutil/trace.go:171","msg":"trace[504847601] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"145.494501ms","start":"2026-03-20T05:33:14.8496Z","end":"2026-03-20T05:33:14.995094Z","steps":["trace[504847601] 'process raft request'  (duration: 83.707156ms)","trace[504847601] 'compare'  (duration: 61.627321ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:14.995148Z","caller":"traceutil/trace.go:171","msg":"trace[255737211] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"115.511509ms","start":"2026-03-20T05:33:14.879618Z","end":"2026-03-20T05:33:14.995129Z","steps":["trace[255737211] 'process raft request'  (duration: 115.476578ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:14.995319Z","caller":"traceutil/trace.go:171","msg":"trace[559055239] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"144.07582ms","start":"2026-03-20T05:33:14.851229Z","end":"2026-03-20T05:33:14.995305Z","steps":["trace[559055239] 'process raft request'  (duration: 143.810064ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.571228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015078006,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:33:18.867596Z","caller":"traceutil/trace.go:171","msg":"trace[1483799055] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:915; }","duration":"797.23685ms","start":"2026-03-20T05:33:18.070335Z","end":"2026-03-20T05:33:18.867572Z","steps":["trace[1483799055] 'read index received'  (duration: 797.036655ms)","trace[1483799055] 'applied index is now lower than readState.Index'  (duration: 199.315µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:18.867717Z","caller":"traceutil/trace.go:171","msg":"trace[251395514] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"944.646905ms","start":"2026-03-20T05:33:17.923059Z","end":"2026-03-20T05:33:18.867706Z","steps":["trace[251395514] 'process raft request'  (duration: 944.375829ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.867829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:17.923037Z","time spent":"944.710596ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:879 > 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-03-20T05:33:18.867966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.772104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:18.868036Z","caller":"traceutil/trace.go:171","msg":"trace[1772705622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:884; }","duration":"458.899387ms","start":"2026-03-20T05:33:18.409119Z","end":"2026-03-20T05:33:18.868018Z","steps":["trace[1772705622] 'agreement among raft nodes before linearized reading'  (duration: 458.793515ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.868039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.708381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-20T05:33:18.868067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.01522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-20T05:33:18.868074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.409088Z","time spent":"458.977688ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T05:33:18.86808Z","caller":"traceutil/trace.go:171","msg":"trace[519010274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:884; }","duration":"797.786483ms","start":"2026-03-20T05:33:18.070281Z","end":"2026-03-20T05:33:18.868067Z","steps":["trace[519010274] 'agreement among raft nodes before linearized reading'  (duration: 797.66543ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.868108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.07026Z","time spent":"797.843513ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T05:33:18.868116Z","caller":"traceutil/trace.go:171","msg":"trace[1294484364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:884; }","duration":"791.068752ms","start":"2026-03-20T05:33:18.077026Z","end":"2026-03-20T05:33:18.868095Z","steps":["trace[1294484364] 'agreement among raft nodes before linearized reading'  (duration: 790.9838ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.867977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.803555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-20T05:33:18.868153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.077017Z","time spent":"791.128853ms","remote":"127.0.0.1:56760","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":"info","ts":"2026-03-20T05:33:18.868163Z","caller":"traceutil/trace.go:171","msg":"trace[819844507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:884; }","duration":"795.000709ms","start":"2026-03-20T05:33:18.073156Z","end":"2026-03-20T05:33:18.868156Z","steps":["trace[819844507] 'agreement among raft nodes before linearized reading'  (duration: 794.679052ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.868182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.073126Z","time spent":"795.050911ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T05:33:18.868281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.979449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-20T05:33:18.868305Z","caller":"traceutil/trace.go:171","msg":"trace[778122720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:884; }","duration":"795.040061ms","start":"2026-03-20T05:33:18.073257Z","end":"2026-03-20T05:33:18.868297Z","steps":["trace[778122720] 'agreement among raft nodes before linearized reading'  (duration: 794.971499ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:18.868331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.073235Z","time spent":"795.090711ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T05:33:19.606059Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015078010,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T05:33:20.106849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015078010,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T05:33:20.343522Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.471165037s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T05:33:20.343954Z","caller":"traceutil/trace.go:171","msg":"trace[721303755] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"1.471646837s","start":"2026-03-20T05:33:18.872285Z","end":"2026-03-20T05:33:20.343931Z","steps":["trace[721303755] 'process raft request'  (duration: 1.471514544s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:20.344075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.872269Z","time spent":"1.47174584s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:883 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:33:20.348939Z","caller":"traceutil/trace.go:171","msg":"trace[1956846345] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"1.476395044s","start":"2026-03-20T05:33:18.872525Z","end":"2026-03-20T05:33:20.34892Z","steps":["trace[1956846345] 'process raft request'  (duration: 1.476260511s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:20.34904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.872512Z","time spent":"1.476465785s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:880 > 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-03-20T05:33:20.349136Z","caller":"traceutil/trace.go:171","msg":"trace[536992113] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"1.476461205s","start":"2026-03-20T05:33:18.872663Z","end":"2026-03-20T05:33:20.349125Z","steps":["trace[536992113] 'process raft request'  (duration: 1.47622406s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:20.34921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.872658Z","time spent":"1.476518956s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:881 > 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":"info","ts":"2026-03-20T05:33:20.349317Z","caller":"traceutil/trace.go:171","msg":"trace[2090913386] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"1.475710869s","start":"2026-03-20T05:33:18.873577Z","end":"2026-03-20T05:33:20.349287Z","steps":["trace[2090913386] 'process raft request'  (duration: 1.475480424s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:20.349426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244260081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-20T05:33:20.349431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:18.87357Z","time spent":"1.475805991s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:882 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:33:20.349462Z","caller":"traceutil/trace.go:171","msg":"trace[673710915] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:888; }","duration":"1.244331883s","start":"2026-03-20T05:33:19.105121Z","end":"2026-03-20T05:33:20.349453Z","steps":["trace[673710915] 'agreement among raft nodes before linearized reading'  (duration: 1.24422583s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:20.34949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:19.1051Z","time spent":"1.244385093s","remote":"127.0.0.1:56584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "}
{"level":"info","ts":"2026-03-20T05:33:20.349748Z","caller":"traceutil/trace.go:171","msg":"trace[1242910832] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:916; }","duration":"1.244084487s","start":"2026-03-20T05:33:19.105172Z","end":"2026-03-20T05:33:20.349257Z","steps":["trace[1242910832] 'read index received'  (duration: 1.238617615s)","trace[1242910832] 'applied index is now lower than readState.Index'  (duration: 5.465962ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:22.535939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.855134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:22.536002Z","caller":"traceutil/trace.go:171","msg":"trace[592857387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:895; }","duration":"130.959027ms","start":"2026-03-20T05:33:22.405025Z","end":"2026-03-20T05:33:22.535984Z","steps":["trace[592857387] 'agreement among raft nodes before linearized reading'  (duration: 130.845294ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:22.535916Z","caller":"traceutil/trace.go:171","msg":"trace[920502541] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"155.769963ms","start":"2026-03-20T05:33:22.380083Z","end":"2026-03-20T05:33:22.535853Z","steps":["trace[920502541] 'process raft request'  (duration: 108.227387ms)","trace[920502541] 'compare'  (duration: 47.331111ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:23.722912Z","caller":"traceutil/trace.go:171","msg":"trace[1018486961] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"264.54518ms","start":"2026-03-20T05:33:23.458338Z","end":"2026-03-20T05:33:23.722883Z","steps":["trace[1018486961] 'process raft request'  (duration: 264.325715ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:24.677168Z","caller":"traceutil/trace.go:171","msg":"trace[1470731223] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"132.628903ms","start":"2026-03-20T05:33:24.544519Z","end":"2026-03-20T05:33:24.677148Z","steps":["trace[1470731223] 'process raft request'  (duration: 124.169633ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:39.429153Z","caller":"traceutil/trace.go:171","msg":"trace[791861603] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"198.06946ms","start":"2026-03-20T05:33:39.231044Z","end":"2026-03-20T05:33:39.429113Z","steps":["trace[791861603] 'process raft request'  (duration: 178.060631ms)","trace[791861603] 'compare'  (duration: 19.479267ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:39.429148Z","caller":"traceutil/trace.go:171","msg":"trace[1046533653] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"194.764156ms","start":"2026-03-20T05:33:39.234352Z","end":"2026-03-20T05:33:39.429116Z","steps":["trace[1046533653] 'process raft request'  (duration: 194.405478ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.674785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.664403ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015078204 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:33:41.674916Z","caller":"traceutil/trace.go:171","msg":"trace[1292784116] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"1.068333597s","start":"2026-03-20T05:33:40.606564Z","end":"2026-03-20T05:33:41.674898Z","steps":["trace[1292784116] 'process raft request'  (duration: 563.341627ms)","trace[1292784116] 'compare'  (duration: 504.161061ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:41.674953Z","caller":"traceutil/trace.go:171","msg":"trace[143264023] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"772.919805ms","start":"2026-03-20T05:33:40.902021Z","end":"2026-03-20T05:33:41.67494Z","steps":["trace[143264023] 'process raft request'  (duration: 772.860084ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.674978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:40.606544Z","time spent":"1.06840713s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:41.675021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:40.901996Z","time spent":"772.991656ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:917 > 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-03-20T05:33:41.675117Z","caller":"traceutil/trace.go:171","msg":"trace[517969881] linearizableReadLoop","detail":"{readStateIndex:1000; appliedIndex:999; }","duration":"978.824701ms","start":"2026-03-20T05:33:40.696285Z","end":"2026-03-20T05:33:41.67511Z","steps":["trace[517969881] 'read index received'  (duration: 473.635147ms)","trace[517969881] 'applied index is now lower than readState.Index'  (duration: 505.188624ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:41.675248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.967885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:33:41.675272Z","caller":"traceutil/trace.go:171","msg":"trace[1170342341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"979.030456ms","start":"2026-03-20T05:33:40.696235Z","end":"2026-03-20T05:33:41.675265Z","steps":["trace[1170342341] 'agreement among raft nodes before linearized reading'  (duration: 978.931273ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.675291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:40.696217Z","time spent":"979.070087ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T05:33:41.675563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.883048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:33:41.675625Z","caller":"traceutil/trace.go:171","msg":"trace[735776479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:964; }","duration":"903.009501ms","start":"2026-03-20T05:33:40.772603Z","end":"2026-03-20T05:33:41.675612Z","steps":["trace[735776479] 'agreement among raft nodes before linearized reading'  (duration: 902.826897ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.675659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.721182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:41.67571Z","caller":"traceutil/trace.go:171","msg":"trace[334007789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"267.807263ms","start":"2026-03-20T05:33:41.407892Z","end":"2026-03-20T05:33:41.675699Z","steps":["trace[334007789] 'agreement among raft nodes before linearized reading'  (duration: 267.740222ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.675757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.340018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-20T05:33:41.675794Z","caller":"traceutil/trace.go:171","msg":"trace[1714068567] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:964; }","duration":"592.403349ms","start":"2026-03-20T05:33:41.083382Z","end":"2026-03-20T05:33:41.675785Z","steps":["trace[1714068567] 'agreement among raft nodes before linearized reading'  (duration: 592.311887ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.675837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:41.083365Z","time spent":"592.465511ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-20T05:33:41.675669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:40.772543Z","time spent":"903.111283ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T05:33:41.676023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.290989ms","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-03-20T05:33:41.676056Z","caller":"traceutil/trace.go:171","msg":"trace[21918651] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:964; }","duration":"829.371141ms","start":"2026-03-20T05:33:40.846674Z","end":"2026-03-20T05:33:41.676045Z","steps":["trace[21918651] 'agreement among raft nodes before linearized reading'  (duration: 829.310959ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:41.676086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:40.846653Z","time spent":"829.425522ms","remote":"127.0.0.1:56916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-03-20T05:33:42.283224Z","caller":"traceutil/trace.go:171","msg":"trace[16392253] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"604.250635ms","start":"2026-03-20T05:33:41.678949Z","end":"2026-03-20T05:33:42.283199Z","steps":["trace[16392253] 'process raft request'  (duration: 604.104042ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:42.283379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:41.678932Z","time spent":"604.364948ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:953 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-20T05:33:42.315249Z","caller":"traceutil/trace.go:171","msg":"trace[1583250259] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"635.610369ms","start":"2026-03-20T05:33:41.679614Z","end":"2026-03-20T05:33:42.315225Z","steps":["trace[1583250259] 'process raft request'  (duration: 635.412354ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:42.315414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:41.679602Z","time spent":"635.716901ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-20T05:33:42.316327Z","caller":"traceutil/trace.go:171","msg":"trace[576736416] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"635.878894ms","start":"2026-03-20T05:33:41.679704Z","end":"2026-03-20T05:33:42.315582Z","steps":["trace[576736416] 'process raft request'  (duration: 635.460775ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:42.316669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:41.679693Z","time spent":"636.921048ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:956 > 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":"warn","ts":"2026-03-20T05:33:43.682175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.989075ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015078218 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:33:43.682242Z","caller":"traceutil/trace.go:171","msg":"trace[1180718722] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"291.331421ms","start":"2026-03-20T05:33:43.3909Z","end":"2026-03-20T05:33:43.682231Z","steps":["trace[1180718722] 'read index received'  (duration: 32.631µs)","trace[1180718722] 'applied index is now lower than readState.Index'  (duration: 291.29804ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:43.682323Z","caller":"traceutil/trace.go:171","msg":"trace[1561795545] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"567.335007ms","start":"2026-03-20T05:33:43.114981Z","end":"2026-03-20T05:33:43.682316Z","steps":["trace[1561795545] 'process raft request'  (duration: 68.155547ms)","trace[1561795545] 'compare'  (duration: 498.826792ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:43.682381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.114965Z","time spent":"567.381687ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T05:33:43.682431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.514574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T05:33:43.682494Z","caller":"traceutil/trace.go:171","msg":"trace[583398986] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:971; }","duration":"291.625497ms","start":"2026-03-20T05:33:43.390853Z","end":"2026-03-20T05:33:43.682478Z","steps":["trace[583398986] 'agreement among raft nodes before linearized reading'  (duration: 291.478394ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:44.149335Z","caller":"traceutil/trace.go:171","msg":"trace[1617260633] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"467.05308ms","start":"2026-03-20T05:33:43.682259Z","end":"2026-03-20T05:33:44.149312Z","steps":["trace[1617260633] 'read index received'  (duration: 465.000663ms)","trace[1617260633] 'applied index is now lower than readState.Index'  (duration: 2.051117ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:44.149371Z","caller":"traceutil/trace.go:171","msg":"trace[2066560486] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"469.394032ms","start":"2026-03-20T05:33:43.67994Z","end":"2026-03-20T05:33:44.149334Z","steps":["trace[2066560486] 'process raft request'  (duration: 467.306715ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.149534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.936679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T05:33:44.149616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.159876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:33:44.149619Z","caller":"traceutil/trace.go:171","msg":"trace[746585807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"741.074452ms","start":"2026-03-20T05:33:43.408526Z","end":"2026-03-20T05:33:44.1496Z","steps":["trace[746585807] 'agreement among raft nodes before linearized reading'  (duration: 740.938839ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.149673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.408502Z","time spent":"741.162573ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:33:44.149601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.679911Z","time spent":"469.586037ms","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-59vs7.189e75cc541f1bdb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-59vs7.189e75cc541f1bdb\" value_size:683 lease:3880868169015077949 >> failure:<>"}
{"level":"info","ts":"2026-03-20T05:33:44.149665Z","caller":"traceutil/trace.go:171","msg":"trace[1643950865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"469.294519ms","start":"2026-03-20T05:33:43.680358Z","end":"2026-03-20T05:33:44.149652Z","steps":["trace[1643950865] 'agreement among raft nodes before linearized reading'  (duration: 469.061534ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.14982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.680345Z","time spent":"469.461763ms","remote":"127.0.0.1:56760","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-03-20T05:33:44.649933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015078223,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:33:44.930218Z","caller":"traceutil/trace.go:171","msg":"trace[1607019768] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"1.244502017s","start":"2026-03-20T05:33:43.685684Z","end":"2026-03-20T05:33:44.930186Z","steps":["trace[1607019768] 'process raft request'  (duration: 1.170286133s)","trace[1607019768] 'compare'  (duration: 73.774273ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:44.930278Z","caller":"traceutil/trace.go:171","msg":"trace[1212416429] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"1.124161419s","start":"2026-03-20T05:33:43.806092Z","end":"2026-03-20T05:33:44.930254Z","steps":["trace[1212416429] 'process raft request'  (duration: 1.123827532s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.930545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.806068Z","time spent":"1.124401695s","remote":"127.0.0.1:56700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5817,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:954 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5783 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:44.930356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.685672Z","time spent":"1.244621049s","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189e75cc54983db1\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189e75cc54983db1\" value_size:692 lease:3880868169015077949 >> failure:<>"}
{"level":"info","ts":"2026-03-20T05:33:44.965381Z","caller":"traceutil/trace.go:171","msg":"trace[1862921732] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"811.174432ms","start":"2026-03-20T05:33:44.15418Z","end":"2026-03-20T05:33:44.965354Z","steps":["trace[1862921732] 'process raft request'  (duration: 811.047679ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.965531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.154158Z","time spent":"811.297255ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:963 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:33:44.965851Z","caller":"traceutil/trace.go:171","msg":"trace[1292177636] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"812.034382ms","start":"2026-03-20T05:33:44.153791Z","end":"2026-03-20T05:33:44.965825Z","steps":["trace[1292177636] 'process raft request'  (duration: 811.320216ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.966035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.153774Z","time spent":"812.144224ms","remote":"127.0.0.1:56628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-59vs7.189e75cc542ace24\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-59vs7.189e75cc542ace24\" value_size:731 lease:3880868169015077949 >> failure:<>"}
{"level":"info","ts":"2026-03-20T05:33:44.965997Z","caller":"traceutil/trace.go:171","msg":"trace[852454713] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"776.902734ms","start":"2026-03-20T05:33:44.188755Z","end":"2026-03-20T05:33:44.965658Z","steps":["trace[852454713] 'process raft request'  (duration: 776.529356ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:44.967407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.188742Z","time spent":"778.167343ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:925 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:45.196834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.271281ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:45.196953Z","caller":"traceutil/trace.go:171","msg":"trace[226930642] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:977; }","duration":"118.407774ms","start":"2026-03-20T05:33:45.078529Z","end":"2026-03-20T05:33:45.196937Z","steps":["trace[226930642] 'range keys from in-memory index tree'  (duration: 118.254561ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.196867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.304366ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015078227 > lease_revoke:<id:35db9d09ba43acc6>","response":"size:27"}
{"level":"info","ts":"2026-03-20T05:33:45.197123Z","caller":"traceutil/trace.go:171","msg":"trace[750029636] linearizableReadLoop","detail":"{readStateIndex:1015; appliedIndex:1009; }","duration":"1.047699165s","start":"2026-03-20T05:33:44.149399Z","end":"2026-03-20T05:33:45.197098Z","steps":["trace[750029636] 'read index received'  (duration: 706.781222ms)","trace[750029636] 'applied index is now lower than readState.Index'  (duration: 340.916032ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:45.197237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046410606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:45.197264Z","caller":"traceutil/trace.go:171","msg":"trace[132442368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"1.046479028s","start":"2026-03-20T05:33:44.150777Z","end":"2026-03-20T05:33:45.197256Z","steps":["trace[132442368] 'agreement among raft nodes before linearized reading'  (duration: 1.046434347s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.197286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.150758Z","time spent":"1.046523299s","remote":"127.0.0.1:56532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:33:45.197226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233260904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:45.197613Z","caller":"traceutil/trace.go:171","msg":"trace[1197510781] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:977; }","duration":"1.233694454s","start":"2026-03-20T05:33:43.963902Z","end":"2026-03-20T05:33:45.197597Z","steps":["trace[1197510781] 'agreement among raft nodes before linearized reading'  (duration: 1.233226053s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.197324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511669855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-20T05:33:45.197751Z","caller":"traceutil/trace.go:171","msg":"trace[1917568804] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:977; }","duration":"1.512126586s","start":"2026-03-20T05:33:43.685608Z","end":"2026-03-20T05:33:45.197735Z","steps":["trace[1917568804] 'agreement among raft nodes before linearized reading'  (duration: 1.511570963s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.197792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.685599Z","time spent":"1.512182507s","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-20T05:33:45.19775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:43.963886Z","time spent":"1.233846898s","remote":"127.0.0.1:56788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:33:45.19742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.548509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:33:45.198052Z","caller":"traceutil/trace.go:171","msg":"trace[369637092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:977; }","duration":"873.190422ms","start":"2026-03-20T05:33:44.32485Z","end":"2026-03-20T05:33:45.198041Z","steps":["trace[369637092] 'agreement among raft nodes before linearized reading'  (duration: 872.512287ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.198091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.324844Z","time spent":"873.236533ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T05:33:45.197498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.685091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-20T05:33:45.198241Z","caller":"traceutil/trace.go:171","msg":"trace[2136692787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:977; }","duration":"873.395837ms","start":"2026-03-20T05:33:44.324787Z","end":"2026-03-20T05:33:45.198182Z","steps":["trace[2136692787] 'agreement among raft nodes before linearized reading'  (duration: 872.633481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.197524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.889192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-20T05:33:45.198325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.324777Z","time spent":"873.50336ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-20T05:33:45.198366Z","caller":"traceutil/trace.go:171","msg":"trace[1008704839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:977; }","duration":"536.769881ms","start":"2026-03-20T05:33:44.661575Z","end":"2026-03-20T05:33:45.198345Z","steps":["trace[1008704839] 'agreement among raft nodes before linearized reading'  (duration: 535.888962ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.197535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.890696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:33:45.198493Z","caller":"traceutil/trace.go:171","msg":"trace[1749919743] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"910.912838ms","start":"2026-03-20T05:33:44.287569Z","end":"2026-03-20T05:33:45.198482Z","steps":["trace[1749919743] 'agreement among raft nodes before linearized reading'  (duration: 909.883565ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.198534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.287556Z","time spent":"910.96622ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T05:33:45.198861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:44.66155Z","time spent":"536.906024ms","remote":"127.0.0.1:56760","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-03-20T05:33:45.326503Z","caller":"traceutil/trace.go:171","msg":"trace[1884347385] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"123.182661ms","start":"2026-03-20T05:33:45.203301Z","end":"2026-03-20T05:33:45.326484Z","steps":["trace[1884347385] 'read index received'  (duration: 123.003577ms)","trace[1884347385] 'applied index is now lower than readState.Index'  (duration: 178.424µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:45.326734Z","caller":"traceutil/trace.go:171","msg":"trace[990161565] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"123.623971ms","start":"2026-03-20T05:33:45.203098Z","end":"2026-03-20T05:33:45.326722Z","steps":["trace[990161565] 'process raft request'  (duration: 123.236902ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.3271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.782075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:45.327144Z","caller":"traceutil/trace.go:171","msg":"trace[1496493372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:978; }","duration":"123.842026ms","start":"2026-03-20T05:33:45.203284Z","end":"2026-03-20T05:33:45.327126Z","steps":["trace[1496493372] 'agreement among raft nodes before linearized reading'  (duration: 123.285123ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:45.596059Z","caller":"traceutil/trace.go:171","msg":"trace[1855827958] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"392.61341ms","start":"2026-03-20T05:33:45.203418Z","end":"2026-03-20T05:33:45.596032Z","steps":["trace[1855827958] 'process raft request'  (duration: 392.327014ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:45.596089Z","caller":"traceutil/trace.go:171","msg":"trace[885677554] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1016; }","duration":"267.649539ms","start":"2026-03-20T05:33:45.328412Z","end":"2026-03-20T05:33:45.596062Z","steps":["trace[885677554] 'read index received'  (duration: 267.26433ms)","trace[885677554] 'applied index is now lower than readState.Index'  (duration: 384.079µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:45.59619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:45.203412Z","time spent":"392.709082ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:969 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:45.596221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.783012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:45.596268Z","caller":"traceutil/trace.go:171","msg":"trace[575959296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"267.878454ms","start":"2026-03-20T05:33:45.328376Z","end":"2026-03-20T05:33:45.596254Z","steps":["trace[575959296] 'agreement among raft nodes before linearized reading'  (duration: 267.776022ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:45.596343Z","caller":"traceutil/trace.go:171","msg":"trace[532271] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"392.337415ms","start":"2026-03-20T05:33:45.203981Z","end":"2026-03-20T05:33:45.596319Z","steps":["trace[532271] 'process raft request'  (duration: 391.983997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.596489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:45.203956Z","time spent":"392.455317ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:966 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-20T05:33:45.596513Z","caller":"traceutil/trace.go:171","msg":"trace[546141279] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"391.987197ms","start":"2026-03-20T05:33:45.204512Z","end":"2026-03-20T05:33:45.5965Z","steps":["trace[546141279] 'process raft request'  (duration: 391.498205ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:45.596554Z","caller":"traceutil/trace.go:171","msg":"trace[834482988] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"392.667793ms","start":"2026-03-20T05:33:45.203874Z","end":"2026-03-20T05:33:45.596542Z","steps":["trace[834482988] 'process raft request'  (duration: 392.030207ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:45.596616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:45.204496Z","time spent":"392.051028ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:967 > 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-03-20T05:33:45.596627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:45.203866Z","time spent":"392.725564ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:971 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:47.4875Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015078239,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:33:47.749918Z","caller":"traceutil/trace.go:171","msg":"trace[2042554824] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"763.246399ms","start":"2026-03-20T05:33:46.986647Z","end":"2026-03-20T05:33:47.749894Z","steps":["trace[2042554824] 'read index received'  (duration: 763.120306ms)","trace[2042554824] 'applied index is now lower than readState.Index'  (duration: 125.103µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:47.75004Z","caller":"traceutil/trace.go:171","msg":"trace[814778095] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"775.77815ms","start":"2026-03-20T05:33:46.974252Z","end":"2026-03-20T05:33:47.750031Z","steps":["trace[814778095] 'process raft request'  (duration: 775.508214ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:47.750134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:46.974236Z","time spent":"775.831711ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:47.750188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.310311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:47.750253Z","caller":"traceutil/trace.go:171","msg":"trace[2056296938] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:983; }","duration":"759.411882ms","start":"2026-03-20T05:33:46.990824Z","end":"2026-03-20T05:33:47.750236Z","steps":["trace[2056296938] 'agreement among raft nodes before linearized reading'  (duration: 759.28805ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:47.750312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:46.990812Z","time spent":"759.490385ms","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:33:47.75052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.958271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T05:33:47.750564Z","caller":"traceutil/trace.go:171","msg":"trace[1350239717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:983; }","duration":"150.023042ms","start":"2026-03-20T05:33:47.60053Z","end":"2026-03-20T05:33:47.750553Z","steps":["trace[1350239717] 'agreement among raft nodes before linearized reading'  (duration: 149.89938ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:47.750582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.37378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:33:47.750622Z","caller":"traceutil/trace.go:171","msg":"trace[1946576979] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:983; }","duration":"150.448722ms","start":"2026-03-20T05:33:47.600163Z","end":"2026-03-20T05:33:47.750612Z","steps":["trace[1946576979] 'agreement among raft nodes before linearized reading'  (duration: 150.324229ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:47.750728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.075807ms","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":"warn","ts":"2026-03-20T05:33:47.750767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.024674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:47.750784Z","caller":"traceutil/trace.go:171","msg":"trace[236809392] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:983; }","duration":"764.162979ms","start":"2026-03-20T05:33:46.986607Z","end":"2026-03-20T05:33:47.75077Z","steps":["trace[236809392] 'agreement among raft nodes before linearized reading'  (duration: 764.067706ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:47.750796Z","caller":"traceutil/trace.go:171","msg":"trace[416559073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:983; }","duration":"270.086814ms","start":"2026-03-20T05:33:47.480699Z","end":"2026-03-20T05:33:47.750785Z","steps":["trace[416559073] 'agreement among raft nodes before linearized reading'  (duration: 270.048514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:47.750813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:46.986591Z","time spent":"764.214291ms","remote":"127.0.0.1:56758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:33:47.750954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.952364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:33:47.750986Z","caller":"traceutil/trace.go:171","msg":"trace[1345621142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:983; }","duration":"420.019995ms","start":"2026-03-20T05:33:47.330958Z","end":"2026-03-20T05:33:47.750978Z","steps":["trace[1345621142] 'agreement among raft nodes before linearized reading'  (duration: 419.942633ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:47.751009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:47.330933Z","time spent":"420.071086ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T05:33:47.751015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.44988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:33:47.751046Z","caller":"traceutil/trace.go:171","msg":"trace[1487813952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:983; }","duration":"149.498102ms","start":"2026-03-20T05:33:47.601538Z","end":"2026-03-20T05:33:47.751036Z","steps":["trace[1487813952] 'agreement among raft nodes before linearized reading'  (duration: 149.41044ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:48.131518Z","caller":"traceutil/trace.go:171","msg":"trace[538349254] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"375.990227ms","start":"2026-03-20T05:33:47.755504Z","end":"2026-03-20T05:33:48.131494Z","steps":["trace[538349254] 'process raft request'  (duration: 375.814033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:48.131659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:47.755497Z","time spent":"376.09099ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:979 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-20T05:33:48.131854Z","caller":"traceutil/trace.go:171","msg":"trace[1643809875] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"375.281242ms","start":"2026-03-20T05:33:47.756541Z","end":"2026-03-20T05:33:48.131822Z","steps":["trace[1643809875] 'process raft request'  (duration: 374.915573ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:48.132031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:47.756526Z","time spent":"375.404065ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:978 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-20T05:33:48.13205Z","caller":"traceutil/trace.go:171","msg":"trace[911730647] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"375.325643ms","start":"2026-03-20T05:33:47.756696Z","end":"2026-03-20T05:33:48.132022Z","steps":["trace[911730647] 'process raft request'  (duration: 375.053367ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:48.13218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:47.756669Z","time spent":"375.441206ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:982 > 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-03-20T05:33:49.90882Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868169015078249,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:33:49.957018Z","caller":"traceutil/trace.go:171","msg":"trace[1114975917] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"788.965366ms","start":"2026-03-20T05:33:49.168021Z","end":"2026-03-20T05:33:49.956986Z","steps":["trace[1114975917] 'process raft request'  (duration: 750.963244ms)","trace[1114975917] 'compare'  (duration: 37.663114ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:49.957006Z","caller":"traceutil/trace.go:171","msg":"trace[1615452767] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"549.031747ms","start":"2026-03-20T05:33:49.407943Z","end":"2026-03-20T05:33:49.956975Z","steps":["trace[1615452767] 'read index received'  (duration: 510.979183ms)","trace[1615452767] 'applied index is now lower than readState.Index'  (duration: 38.050574ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:33:49.957173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:49.167997Z","time spent":"789.105028ms","remote":"127.0.0.1:56584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.229\" mod_revision:957 > success:<request_put:<key:\"/registry/masterleases/199.204.45.229\" value_size:67 lease:3880868169015078250 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.229\" > >"}
{"level":"warn","ts":"2026-03-20T05:33:49.957373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.522887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:33:49.957442Z","caller":"traceutil/trace.go:171","msg":"trace[1414703176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:988; }","duration":"201.66746ms","start":"2026-03-20T05:33:49.755746Z","end":"2026-03-20T05:33:49.957413Z","steps":["trace[1414703176] 'agreement among raft nodes before linearized reading'  (duration: 201.508957ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:49.957476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.389194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T05:33:49.957551Z","caller":"traceutil/trace.go:171","msg":"trace[530962081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:988; }","duration":"176.500386ms","start":"2026-03-20T05:33:49.781034Z","end":"2026-03-20T05:33:49.957535Z","steps":["trace[530962081] 'agreement among raft nodes before linearized reading'  (duration: 176.284081ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:49.9578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.236902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:49.958316Z","caller":"traceutil/trace.go:171","msg":"trace[1186430633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"550.418748ms","start":"2026-03-20T05:33:49.407884Z","end":"2026-03-20T05:33:49.958303Z","steps":["trace[1186430633] 'agreement among raft nodes before linearized reading'  (duration: 549.170109ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:49.958374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:49.40786Z","time spent":"550.49873ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:33:51.69715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.778975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:51.69723Z","caller":"traceutil/trace.go:171","msg":"trace[1420173010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"289.893918ms","start":"2026-03-20T05:33:51.407321Z","end":"2026-03-20T05:33:51.697215Z","steps":["trace[1420173010] 'range keys from in-memory index tree'  (duration: 289.711544ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:51.69715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.970732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:51.697363Z","caller":"traceutil/trace.go:171","msg":"trace[1293767934] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:996; }","duration":"523.216108ms","start":"2026-03-20T05:33:51.174127Z","end":"2026-03-20T05:33:51.697344Z","steps":["trace[1293767934] 'range keys from in-memory index tree'  (duration: 522.87189ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:33:51.697406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:33:51.174107Z","time spent":"523.288529ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-20T05:33:55.464772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.156524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:33:55.464853Z","caller":"traceutil/trace.go:171","msg":"trace[825504613] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1027; }","duration":"286.271586ms","start":"2026-03-20T05:33:55.178559Z","end":"2026-03-20T05:33:55.464831Z","steps":["trace[825504613] 'range keys from in-memory index tree'  (duration: 286.057652ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:55.465295Z","caller":"traceutil/trace.go:171","msg":"trace[1060549432] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"261.87786ms","start":"2026-03-20T05:33:55.20339Z","end":"2026-03-20T05:33:55.465268Z","steps":["trace[1060549432] 'process raft request'  (duration: 260.303265ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:33:58.218286Z","caller":"traceutil/trace.go:171","msg":"trace[489763857] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"118.550917ms","start":"2026-03-20T05:33:58.099704Z","end":"2026-03-20T05:33:58.218255Z","steps":["trace[489763857] 'process raft request'  (duration: 59.703078ms)","trace[489763857] 'compare'  (duration: 58.654525ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:33:58.413063Z","caller":"traceutil/trace.go:171","msg":"trace[1959136536] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"190.450299ms","start":"2026-03-20T05:33:58.222565Z","end":"2026-03-20T05:33:58.413015Z","steps":["trace[1959136536] 'process raft request'  (duration: 190.159782ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:18.684719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.096296ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880868169015078575 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1112 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:34:18.684821Z","caller":"traceutil/trace.go:171","msg":"trace[1181019801] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"120.743266ms","start":"2026-03-20T05:34:18.564063Z","end":"2026-03-20T05:34:18.684806Z","steps":["trace[1181019801] 'read index received'  (duration: 19.430425ms)","trace[1181019801] 'applied index is now lower than readState.Index'  (duration: 101.311711ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:34:18.684907Z","caller":"traceutil/trace.go:171","msg":"trace[1231888623] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"149.86895ms","start":"2026-03-20T05:34:18.535008Z","end":"2026-03-20T05:34:18.684877Z","steps":["trace[1231888623] 'process raft request'  (duration: 48.533148ms)","trace[1231888623] 'compare'  (duration: 100.999374ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:34:18.684945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.88719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T05:34:18.684986Z","caller":"traceutil/trace.go:171","msg":"trace[1128469354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1135; }","duration":"120.949581ms","start":"2026-03-20T05:34:18.564026Z","end":"2026-03-20T05:34:18.684976Z","steps":["trace[1128469354] 'agreement among raft nodes before linearized reading'  (duration: 120.822698ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:47.5342Z","caller":"traceutil/trace.go:171","msg":"trace[712734103] transaction","detail":"{read_only:false; response_revision:1497; number_of_response:1; }","duration":"120.674576ms","start":"2026-03-20T05:35:47.413392Z","end":"2026-03-20T05:35:47.534066Z","steps":["trace[712734103] 'process raft request'  (duration: 120.294687ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:11.512375Z","caller":"traceutil/trace.go:171","msg":"trace[1223053686] linearizableReadLoop","detail":"{readStateIndex:1662; appliedIndex:1661; }","duration":"106.135809ms","start":"2026-03-20T05:36:11.406214Z","end":"2026-03-20T05:36:11.51235Z","steps":["trace[1223053686] 'read index received'  (duration: 105.886683ms)","trace[1223053686] 'applied index is now lower than readState.Index'  (duration: 247.996µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:11.512456Z","caller":"traceutil/trace.go:171","msg":"trace[767586268] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"110.120938ms","start":"2026-03-20T05:36:11.402307Z","end":"2026-03-20T05:36:11.512428Z","steps":["trace[767586268] 'process raft request'  (duration: 109.896913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:11.512626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.358673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:36:11.512845Z","caller":"traceutil/trace.go:171","msg":"trace[56774946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1595; }","duration":"106.63698ms","start":"2026-03-20T05:36:11.406195Z","end":"2026-03-20T05:36:11.512832Z","steps":["trace[56774946] 'agreement among raft nodes before linearized reading'  (duration: 106.346184ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:31.084866Z","caller":"traceutil/trace.go:171","msg":"trace[2018434668] linearizableReadLoop","detail":"{readStateIndex:1742; appliedIndex:1741; }","duration":"487.059492ms","start":"2026-03-20T05:36:30.597782Z","end":"2026-03-20T05:36:31.084841Z","steps":["trace[2018434668] 'read index received'  (duration: 486.924048ms)","trace[2018434668] 'applied index is now lower than readState.Index'  (duration: 134.464µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:31.084942Z","caller":"traceutil/trace.go:171","msg":"trace[1124147032] transaction","detail":"{read_only:false; response_revision:1671; number_of_response:1; }","duration":"611.399352ms","start":"2026-03-20T05:36:30.473516Z","end":"2026-03-20T05:36:31.084915Z","steps":["trace[1124147032] 'process raft request'  (duration: 611.171646ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:31.085106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:30.473485Z","time spent":"611.527814ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1650 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:432 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-20T05:36:31.085121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.315198ms","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-03-20T05:36:31.085163Z","caller":"traceutil/trace.go:171","msg":"trace[1080622489] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1671; }","duration":"487.385809ms","start":"2026-03-20T05:36:30.597766Z","end":"2026-03-20T05:36:31.085151Z","steps":["trace[1080622489] 'agreement among raft nodes before linearized reading'  (duration: 487.213605ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:31.085194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:30.597674Z","time spent":"487.512432ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-03-20T05:36:31.085262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.3582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-20T05:36:31.085342Z","caller":"traceutil/trace.go:171","msg":"trace[1723057392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1671; }","duration":"208.490413ms","start":"2026-03-20T05:36:30.87683Z","end":"2026-03-20T05:36:31.08532Z","steps":["trace[1723057392] 'agreement among raft nodes before linearized reading'  (duration: 208.195646ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:31.425642Z","caller":"traceutil/trace.go:171","msg":"trace[1474697007] transaction","detail":"{read_only:false; response_revision:1672; number_of_response:1; }","duration":"336.155556ms","start":"2026-03-20T05:36:31.089454Z","end":"2026-03-20T05:36:31.42561Z","steps":["trace[1474697007] 'process raft request'  (duration: 256.810051ms)","trace[1474697007] 'compare'  (duration: 78.949276ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:31.425911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:31.089439Z","time spent":"336.383741ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1663 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-20T05:36:31.426415Z","caller":"traceutil/trace.go:171","msg":"trace[1636297525] transaction","detail":"{read_only:false; response_revision:1673; number_of_response:1; }","duration":"336.862541ms","start":"2026-03-20T05:36:31.089523Z","end":"2026-03-20T05:36:31.426386Z","steps":["trace[1636297525] 'process raft request'  (duration: 335.90772ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:31.426497Z","caller":"traceutil/trace.go:171","msg":"trace[33020630] transaction","detail":"{read_only:false; response_revision:1674; number_of_response:1; }","duration":"335.407938ms","start":"2026-03-20T05:36:31.091061Z","end":"2026-03-20T05:36:31.426469Z","steps":["trace[33020630] 'process raft request'  (duration: 335.196804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:31.426618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:31.089504Z","time spent":"337.005805ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1662 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"info","ts":"2026-03-20T05:36:31.426425Z","caller":"traceutil/trace.go:171","msg":"trace[1870594959] linearizableReadLoop","detail":"{readStateIndex:1745; appliedIndex:1742; }","duration":"290.800485ms","start":"2026-03-20T05:36:31.135593Z","end":"2026-03-20T05:36:31.426393Z","steps":["trace[1870594959] 'read index received'  (duration: 210.693832ms)","trace[1870594959] 'applied index is now lower than readState.Index'  (duration: 80.105083ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:31.42664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.04176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-20T05:36:31.426802Z","caller":"traceutil/trace.go:171","msg":"trace[1204590628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1674; }","duration":"291.264065ms","start":"2026-03-20T05:36:31.135513Z","end":"2026-03-20T05:36:31.426777Z","steps":["trace[1204590628] 'agreement among raft nodes before linearized reading'  (duration: 290.980198ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:31.426636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:31.091045Z","time spent":"335.520731ms","remote":"127.0.0.1:56760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1654 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-20T05:36:31.427488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.70903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:36:31.42754Z","caller":"traceutil/trace.go:171","msg":"trace[2142131666] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1674; }","duration":"133.854903ms","start":"2026-03-20T05:36:31.293672Z","end":"2026-03-20T05:36:31.427527Z","steps":["trace[2142131666] 'agreement among raft nodes before linearized reading'  (duration: 133.126447ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:43.607207Z","caller":"traceutil/trace.go:171","msg":"trace[1095426001] transaction","detail":"{read_only:false; response_revision:1731; number_of_response:1; }","duration":"116.544573ms","start":"2026-03-20T05:36:43.490633Z","end":"2026-03-20T05:36:43.607178Z","steps":["trace[1095426001] 'process raft request'  (duration: 116.39458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:43.607369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.779967ms","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-03-20T05:36:43.607597Z","caller":"traceutil/trace.go:171","msg":"trace[839085988] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1731; }","duration":"116.035822ms","start":"2026-03-20T05:36:43.491508Z","end":"2026-03-20T05:36:43.607544Z","steps":["trace[839085988] 'agreement among raft nodes before linearized reading'  (duration: 115.637693ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:43.767823Z","caller":"traceutil/trace.go:171","msg":"trace[1550797529] transaction","detail":"{read_only:false; response_revision:1734; number_of_response:1; }","duration":"107.54792ms","start":"2026-03-20T05:36:43.660221Z","end":"2026-03-20T05:36:43.767769Z","steps":["trace[1550797529] 'process raft request'  (duration: 96.850079ms)","trace[1550797529] 'compare'  (duration: 10.478336ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:49.860821Z","caller":"traceutil/trace.go:171","msg":"trace[1717881024] linearizableReadLoop","detail":"{readStateIndex:1847; appliedIndex:1846; }","duration":"187.012679ms","start":"2026-03-20T05:36:49.673786Z","end":"2026-03-20T05:36:49.860799Z","steps":["trace[1717881024] 'read index received'  (duration: 97.194288ms)","trace[1717881024] 'applied index is now lower than readState.Index'  (duration: 89.817531ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:49.860924Z","caller":"traceutil/trace.go:171","msg":"trace[612113943] transaction","detail":"{read_only:false; response_revision:1771; number_of_response:1; }","duration":"195.891179ms","start":"2026-03-20T05:36:49.664991Z","end":"2026-03-20T05:36:49.860882Z","steps":["trace[612113943] 'process raft request'  (duration: 106.003536ms)","trace[612113943] 'compare'  (duration: 89.708389ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:49.860994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.193353ms","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-03-20T05:36:49.861023Z","caller":"traceutil/trace.go:171","msg":"trace[1809878444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1771; }","duration":"187.261465ms","start":"2026-03-20T05:36:49.673754Z","end":"2026-03-20T05:36:49.861016Z","steps":["trace[1809878444] 'agreement among raft nodes before linearized reading'  (duration: 187.156143ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:49.861269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.841468ms","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-03-20T05:36:49.861436Z","caller":"traceutil/trace.go:171","msg":"trace[1420585946] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1771; }","duration":"183.963721ms","start":"2026-03-20T05:36:49.677368Z","end":"2026-03-20T05:36:49.861331Z","steps":["trace[1420585946] 'agreement among raft nodes before linearized reading'  (duration: 183.751796ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:59.787904Z","caller":"traceutil/trace.go:171","msg":"trace[1250157852] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1894; }","duration":"529.954464ms","start":"2026-03-20T05:36:59.257925Z","end":"2026-03-20T05:36:59.787879Z","steps":["trace[1250157852] 'read index received'  (duration: 485.922354ms)","trace[1250157852] 'applied index is now lower than readState.Index'  (duration: 44.03059ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:59.788114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:59.118174Z","time spent":"669.933767ms","remote":"127.0.0.1:56584","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-20T05:36:59.788179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.23754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:36:59.788219Z","caller":"traceutil/trace.go:171","msg":"trace[6581389] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1817; }","duration":"530.337892ms","start":"2026-03-20T05:36:59.257869Z","end":"2026-03-20T05:36:59.788206Z","steps":["trace[6581389] 'agreement among raft nodes before linearized reading'  (duration: 530.23563ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:59.788262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:59.257844Z","time spent":"530.408234ms","remote":"127.0.0.1:40026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T05:36:59.811797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.465692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:36:59.811846Z","caller":"traceutil/trace.go:171","msg":"trace[1774207731] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"246.236371ms","start":"2026-03-20T05:36:59.565567Z","end":"2026-03-20T05:36:59.811803Z","steps":["trace[1774207731] 'process raft request'  (duration: 245.982705ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:59.811881Z","caller":"traceutil/trace.go:171","msg":"trace[1505857229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1818; }","duration":"403.594895ms","start":"2026-03-20T05:36:59.408264Z","end":"2026-03-20T05:36:59.811859Z","steps":["trace[1505857229] 'agreement among raft nodes before linearized reading'  (duration: 403.451082ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:59.811932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:59.408243Z","time spent":"403.680937ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:36:59.811977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.184535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-20T05:36:59.812069Z","caller":"traceutil/trace.go:171","msg":"trace[2030860323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1818; }","duration":"110.308937ms","start":"2026-03-20T05:36:59.701738Z","end":"2026-03-20T05:36:59.812047Z","steps":["trace[2030860323] 'agreement among raft nodes before linearized reading'  (duration: 110.079782ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:37:16.312009Z","caller":"traceutil/trace.go:171","msg":"trace[7339757] linearizableReadLoop","detail":"{readStateIndex:1976; appliedIndex:1974; }","duration":"117.457838ms","start":"2026-03-20T05:37:16.19453Z","end":"2026-03-20T05:37:16.311988Z","steps":["trace[7339757] 'read index received'  (duration: 116.889185ms)","trace[7339757] 'applied index is now lower than readState.Index'  (duration: 567.643µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:37:16.312107Z","caller":"traceutil/trace.go:171","msg":"trace[1908415205] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"161.65553ms","start":"2026-03-20T05:37:16.150415Z","end":"2026-03-20T05:37:16.31207Z","steps":["trace[1908415205] 'process raft request'  (duration: 161.518037ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:37:16.312113Z","caller":"traceutil/trace.go:171","msg":"trace[1094536998] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"163.086692ms","start":"2026-03-20T05:37:16.148968Z","end":"2026-03-20T05:37:16.312055Z","steps":["trace[1094536998] 'process raft request'  (duration: 162.460709ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:37:16.312235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.677943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-03-20T05:37:16.312288Z","caller":"traceutil/trace.go:171","msg":"trace[1913279830] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1895; }","duration":"117.803435ms","start":"2026-03-20T05:37:16.19447Z","end":"2026-03-20T05:37:16.312273Z","steps":["trace[1913279830] 'agreement among raft nodes before linearized reading'  (duration: 117.647922ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:37:16.312375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.832466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" ","response":"range_response_count:1 size:783"}
{"level":"info","ts":"2026-03-20T05:37:16.312479Z","caller":"traceutil/trace.go:171","msg":"trace[1873496244] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1895; }","duration":"113.982679ms","start":"2026-03-20T05:37:16.198476Z","end":"2026-03-20T05:37:16.312459Z","steps":["trace[1873496244] 'agreement among raft nodes before linearized reading'  (duration: 113.753004ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:37:16.312385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.839149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:765"}
{"level":"info","ts":"2026-03-20T05:37:16.312605Z","caller":"traceutil/trace.go:171","msg":"trace[2079751983] range","detail":"{range_begin:/registry/clusterrolebindings/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:1895; }","duration":"115.160046ms","start":"2026-03-20T05:37:16.197419Z","end":"2026-03-20T05:37:16.312579Z","steps":["trace[2079751983] 'agreement among raft nodes before linearized reading'  (duration: 114.793768ms)"],"step_count":1}