{"level":"warn","ts":"2026-02-06T00:39:32.125596Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-06T00:39:32.125729Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-06T00:39:32.125797Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-06T00:39:32.125805Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-02-06T00:39:32.125822Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-06T00:39:32.127923Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]}
{"level":"info","ts":"2026-02-06T00:39:32.128278Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-06T00:39:32.132418Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.90015ms"}
{"level":"info","ts":"2026-02-06T00:39:32.140207Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"}
{"level":"info","ts":"2026-02-06T00:39:32.140261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"}
{"level":"info","ts":"2026-02-06T00:39:32.140283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"}
{"level":"info","ts":"2026-02-06T00:39:32.140339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-06T00:39:32.140345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"}
{"level":"info","ts":"2026-02-06T00:39:32.140391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"warn","ts":"2026-02-06T00:39:32.147339Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-06T00:39:32.151288Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-06T00:39:32.157256Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-06T00:39:32.162609Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-06T00:39:32.163009Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-06T00:39:32.163102Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-06T00:39:32.16324Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-06T00:39:32.163279Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-06T00:39:32.178118Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-06T00:39:32.178314Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-06T00:39:32.178344Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-06T00:39:32.178419Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-02-06T00:39:32.178441Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-02-06T00:39:32.178851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"info","ts":"2026-02-06T00:39:32.179016Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-02-06T00:39:32.641683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"}
{"level":"info","ts":"2026-02-06T00:39:32.641802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-06T00:39:32.641835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"}
{"level":"info","ts":"2026-02-06T00:39:32.641882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"}
{"level":"info","ts":"2026-02-06T00:39:32.64198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-02-06T00:39:32.642007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"}
{"level":"info","ts":"2026-02-06T00:39:32.642037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-02-06T00:39:32.644793Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:39:32.645128Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-06T00:39:32.645199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-06T00:39:32.652158Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"}
{"level":"info","ts":"2026-02-06T00:39:32.652443Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:39:32.655477Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:39:32.655564Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:39:32.655789Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-06T00:39:32.657157Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-06T00:39:32.67238Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-06T00:39:32.672409Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"warn","ts":"2026-02-06T00:39:38.315304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.166444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-06T00:39:38.315345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.99567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-06T00:39:38.315372Z","caller":"traceutil/trace.go:171","msg":"trace[1126411989] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:241; }","duration":"194.338018ms","start":"2026-02-06T00:39:38.121022Z","end":"2026-02-06T00:39:38.31536Z","steps":["trace[1126411989] 'range keys from in-memory index tree'  (duration: 194.054232ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:39:38.315411Z","caller":"traceutil/trace.go:171","msg":"trace[1051333607] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:241; }","duration":"343.098562ms","start":"2026-02-06T00:39:37.972298Z","end":"2026-02-06T00:39:38.315397Z","steps":["trace[1051333607] 'range keys from in-memory index tree'  (duration: 342.913148ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:39:38.315439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:39:37.972283Z","time spent":"343.151263ms","remote":"127.0.0.1:55206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-02-06T00:39:38.316938Z","caller":"traceutil/trace.go:171","msg":"trace[776381854] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"102.606419ms","start":"2026-02-06T00:39:38.214322Z","end":"2026-02-06T00:39:38.316929Z","steps":["trace[776381854] 'process raft request'  (duration: 102.526268ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:39:43.896543Z","caller":"traceutil/trace.go:171","msg":"trace[538546083] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"579.791216ms","start":"2026-02-06T00:39:43.31673Z","end":"2026-02-06T00:39:43.896521Z","steps":["trace[538546083] 'process raft request'  (duration: 579.644103ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:39:43.897103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:39:43.31672Z","time spent":"579.914418ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2881,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/kube-proxy\" mod_revision:331 > success:<request_put:<key:\"/registry/daemonsets/kube-system/kube-proxy\" value_size:2830 >> failure:<request_range:<key:\"/registry/daemonsets/kube-system/kube-proxy\" > >"}
{"level":"info","ts":"2026-02-06T00:39:43.900564Z","caller":"traceutil/trace.go:171","msg":"trace[2006583987] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"579.859387ms","start":"2026-02-06T00:39:43.32067Z","end":"2026-02-06T00:39:43.90053Z","steps":["trace[2006583987] 'process raft request'  (duration: 579.683444ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:39:43.900718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:39:43.320652Z","time spent":"579.980359ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5083,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:345 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5035 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >"}
{"level":"info","ts":"2026-02-06T00:39:45.049265Z","caller":"traceutil/trace.go:171","msg":"trace[1264852210] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"133.460272ms","start":"2026-02-06T00:39:44.915783Z","end":"2026-02-06T00:39:45.049244Z","steps":["trace[1264852210] 'process raft request'  (duration: 99.409873ms)","trace[1264852210] 'compare'  (duration: 33.953417ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:39:50.162327Z","caller":"traceutil/trace.go:171","msg":"trace[522772284] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"187.813541ms","start":"2026-02-06T00:39:49.974491Z","end":"2026-02-06T00:39:50.162305Z","steps":["trace[522772284] 'process raft request'  (duration: 187.759249ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:39:50.162432Z","caller":"traceutil/trace.go:171","msg":"trace[1406020177] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"197.911164ms","start":"2026-02-06T00:39:49.964504Z","end":"2026-02-06T00:39:50.162415Z","steps":["trace[1406020177] 'process raft request'  (duration: 193.267125ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:39:50.162559Z","caller":"traceutil/trace.go:171","msg":"trace[791105851] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"191.512108ms","start":"2026-02-06T00:39:49.971034Z","end":"2026-02-06T00:39:50.162546Z","steps":["trace[791105851] 'process raft request'  (duration: 191.15553ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:04.220012Z","caller":"traceutil/trace.go:171","msg":"trace[1324113646] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"149.720574ms","start":"2026-02-06T00:40:04.070274Z","end":"2026-02-06T00:40:04.219995Z","steps":["trace[1324113646] 'process raft request'  (duration: 149.590962ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:05.13449Z","caller":"traceutil/trace.go:171","msg":"trace[130846027] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"126.75451ms","start":"2026-02-06T00:40:05.00772Z","end":"2026-02-06T00:40:05.134475Z","steps":["trace[130846027] 'read index received'  (duration: 126.636118ms)","trace[130846027] 'applied index is now lower than readState.Index'  (duration: 117.892µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:05.134585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.848852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:40:05.134602Z","caller":"traceutil/trace.go:171","msg":"trace[1785525082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:475; }","duration":"126.900913ms","start":"2026-02-06T00:40:05.007695Z","end":"2026-02-06T00:40:05.134596Z","steps":["trace[1785525082] 'agreement among raft nodes before linearized reading'  (duration: 126.838541ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:05.134795Z","caller":"traceutil/trace.go:171","msg":"trace[1254970037] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"241.848713ms","start":"2026-02-06T00:40:04.89294Z","end":"2026-02-06T00:40:05.134789Z","steps":["trace[1254970037] 'process raft request'  (duration: 241.455485ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:06.616142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:06.216889Z","time spent":"399.2493ms","remote":"127.0.0.1:55124","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-06T00:40:07.022801Z","caller":"traceutil/trace.go:171","msg":"trace[1851327870] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"400.409984ms","start":"2026-02-06T00:40:06.622367Z","end":"2026-02-06T00:40:07.022777Z","steps":["trace[1851327870] 'read index received'  (duration: 310.613106ms)","trace[1851327870] 'applied index is now lower than readState.Index'  (duration: 89.795788ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:07.022974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.587768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:07.02303Z","caller":"traceutil/trace.go:171","msg":"trace[1384464574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"400.653099ms","start":"2026-02-06T00:40:06.622361Z","end":"2026-02-06T00:40:07.023014Z","steps":["trace[1384464574] 'agreement among raft nodes before linearized reading'  (duration: 400.513136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:07.023081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:06.622288Z","time spent":"400.781071ms","remote":"127.0.0.1:55118","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-02-06T00:40:07.023141Z","caller":"traceutil/trace.go:171","msg":"trace[1903493013] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"406.245377ms","start":"2026-02-06T00:40:06.616865Z","end":"2026-02-06T00:40:07.023111Z","steps":["trace[1903493013] 'process raft request'  (duration: 316.099702ms)","trace[1903493013] 'compare'  (duration: 89.663025ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:07.023284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:06.616853Z","time spent":"406.346499ms","remote":"127.0.0.1:55124","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.244\" mod_revision:422 > success:<request_put:<key:\"/registry/masterleases/199.204.45.244\" value_size:67 lease:9142197500231954472 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.244\" > >"}
{"level":"warn","ts":"2026-02-06T00:40:07.72752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.206252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:07.727595Z","caller":"traceutil/trace.go:171","msg":"trace[1602555604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"103.330574ms","start":"2026-02-06T00:40:07.624247Z","end":"2026-02-06T00:40:07.727578Z","steps":["trace[1602555604] 'range keys from in-memory index tree'  (duration: 103.13021ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:07.727953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.244485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:40:07.727984Z","caller":"traceutil/trace.go:171","msg":"trace[1985535330] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"589.299446ms","start":"2026-02-06T00:40:07.138675Z","end":"2026-02-06T00:40:07.727975Z","steps":["trace[1985535330] 'range keys from in-memory index tree'  (duration: 589.114123ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:07.728011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.13866Z","time spent":"589.343808ms","remote":"127.0.0.1:55366","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-02-06T00:40:07.728157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.987685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-06T00:40:07.728183Z","caller":"traceutil/trace.go:171","msg":"trace[343646842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:480; }","duration":"540.032125ms","start":"2026-02-06T00:40:07.188142Z","end":"2026-02-06T00:40:07.728174Z","steps":["trace[343646842] 'range keys from in-memory index tree'  (duration: 539.944313ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:07.728206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.188132Z","time spent":"540.069506ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:40:07.728326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.187463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-06T00:40:07.728355Z","caller":"traceutil/trace.go:171","msg":"trace[1703004953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:480; }","duration":"535.229814ms","start":"2026-02-06T00:40:07.193115Z","end":"2026-02-06T00:40:07.728344Z","steps":["trace[1703004953] 'range keys from in-memory index tree'  (duration: 535.149402ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:07.72838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.19311Z","time spent":"535.264854ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-06T00:40:07.728524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.157567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-06T00:40:07.72855Z","caller":"traceutil/trace.go:171","msg":"trace[993265783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"530.194918ms","start":"2026-02-06T00:40:07.198348Z","end":"2026-02-06T00:40:07.728543Z","steps":["trace[993265783] 'range keys from in-memory index tree'  (duration: 530.126606ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:07.728573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.198343Z","time spent":"530.225338ms","remote":"127.0.0.1:55366","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-02-06T00:40:08.312612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.059682ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231954486 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:478 > 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-02-06T00:40:08.312742Z","caller":"traceutil/trace.go:171","msg":"trace[934817348] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"571.665974ms","start":"2026-02-06T00:40:07.741062Z","end":"2026-02-06T00:40:08.312728Z","steps":["trace[934817348] 'process raft request'  (duration: 298.173794ms)","trace[934817348] 'compare'  (duration: 272.948159ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:08.312787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.741044Z","time spent":"571.722075ms","remote":"127.0.0.1:55366","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:478 > 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-02-06T00:40:08.314088Z","caller":"traceutil/trace.go:171","msg":"trace[1464979687] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"572.717167ms","start":"2026-02-06T00:40:07.741363Z","end":"2026-02-06T00:40:08.31408Z","steps":["trace[1464979687] 'process raft request'  (duration: 572.673136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:08.314133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.741358Z","time spent":"572.751468ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:477 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-06T00:40:08.313832Z","caller":"traceutil/trace.go:171","msg":"trace[1401028138] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"572.597125ms","start":"2026-02-06T00:40:07.741226Z","end":"2026-02-06T00:40:08.313823Z","steps":["trace[1401028138] 'process raft request'  (duration: 571.45825ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:08.314447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:07.74122Z","time spent":"573.205927ms","remote":"127.0.0.1:55366","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:476 > 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-02-06T00:40:08.765632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.499199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:08.765732Z","caller":"traceutil/trace.go:171","msg":"trace[1269019072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:484; }","duration":"139.626601ms","start":"2026-02-06T00:40:08.626081Z","end":"2026-02-06T00:40:08.765708Z","steps":["trace[1269019072] 'range keys from in-memory index tree'  (duration: 139.419867ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:12.789197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.904054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:12.78928Z","caller":"traceutil/trace.go:171","msg":"trace[1967902271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:495; }","duration":"164.026077ms","start":"2026-02-06T00:40:12.625237Z","end":"2026-02-06T00:40:12.789263Z","steps":["trace[1967902271] 'range keys from in-memory index tree'  (duration: 163.844822ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:12.789472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.924438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-06T00:40:12.78954Z","caller":"traceutil/trace.go:171","msg":"trace[623341697] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:495; }","duration":"280.028799ms","start":"2026-02-06T00:40:12.509493Z","end":"2026-02-06T00:40:12.789522Z","steps":["trace[623341697] 'range keys from in-memory index tree'  (duration: 279.830186ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:13.074116Z","caller":"traceutil/trace.go:171","msg":"trace[1534683413] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"266.251188ms","start":"2026-02-06T00:40:12.807848Z","end":"2026-02-06T00:40:13.074099Z","steps":["trace[1534683413] 'process raft request'  (duration: 266.144896ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:14.798386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.637481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:14.798434Z","caller":"traceutil/trace.go:171","msg":"trace[1095187979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"175.693193ms","start":"2026-02-06T00:40:14.62273Z","end":"2026-02-06T00:40:14.798424Z","steps":["trace[1095187979] 'range keys from in-memory index tree'  (duration: 175.57948ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:17.693751Z","caller":"traceutil/trace.go:171","msg":"trace[1796187167] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"167.46108ms","start":"2026-02-06T00:40:17.525666Z","end":"2026-02-06T00:40:17.693127Z","steps":["trace[1796187167] 'process raft request'  (duration: 167.231355ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:29.435575Z","caller":"traceutil/trace.go:171","msg":"trace[629938359] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"178.029513ms","start":"2026-02-06T00:40:29.257529Z","end":"2026-02-06T00:40:29.435558Z","steps":["trace[629938359] 'process raft request'  (duration: 177.640435ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:30.077825Z","caller":"traceutil/trace.go:171","msg":"trace[1897448647] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"120.964008ms","start":"2026-02-06T00:40:29.956839Z","end":"2026-02-06T00:40:30.077803Z","steps":["trace[1897448647] 'process raft request'  (duration: 120.784074ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:30.564498Z","caller":"traceutil/trace.go:171","msg":"trace[607834498] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"113.951478ms","start":"2026-02-06T00:40:30.450529Z","end":"2026-02-06T00:40:30.56448Z","steps":["trace[607834498] 'process raft request'  (duration: 113.5613ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:34.086722Z","caller":"traceutil/trace.go:171","msg":"trace[1560658143] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"462.939196ms","start":"2026-02-06T00:40:33.623765Z","end":"2026-02-06T00:40:34.086704Z","steps":["trace[1560658143] 'read index received'  (duration: 462.803064ms)","trace[1560658143] 'applied index is now lower than readState.Index'  (duration: 135.512µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:34.086853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.064819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:34.086878Z","caller":"traceutil/trace.go:171","msg":"trace[1317818596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"463.137991ms","start":"2026-02-06T00:40:33.623731Z","end":"2026-02-06T00:40:34.086869Z","steps":["trace[1317818596] 'agreement among raft nodes before linearized reading'  (duration: 463.044919ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:34.086901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:33.623717Z","time spent":"463.178141ms","remote":"127.0.0.1:55118","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-02-06T00:40:34.087001Z","caller":"traceutil/trace.go:171","msg":"trace[482153012] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"573.009053ms","start":"2026-02-06T00:40:33.513975Z","end":"2026-02-06T00:40:34.086984Z","steps":["trace[482153012] 'process raft request'  (duration: 572.644086ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:34.087108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:33.513955Z","time spent":"573.099565ms","remote":"127.0.0.1:55366","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:685 > 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-02-06T00:40:35.84996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144162354s","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231954890 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:686 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:40:35.850023Z","caller":"traceutil/trace.go:171","msg":"trace[1828042822] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:714; }","duration":"1.264923778s","start":"2026-02-06T00:40:34.585089Z","end":"2026-02-06T00:40:35.850013Z","steps":["trace[1828042822] 'read index received'  (duration: 120.63185ms)","trace[1828042822] 'applied index is now lower than readState.Index'  (duration: 1.144290828s)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:40:35.850152Z","caller":"traceutil/trace.go:171","msg":"trace[631947243] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"1.737286603s","start":"2026-02-06T00:40:34.112856Z","end":"2026-02-06T00:40:35.850142Z","steps":["trace[631947243] 'process raft request'  (duration: 592.880263ms)","trace[631947243] 'compare'  (duration: 1.144097413s)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:35.850193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:34.112846Z","time spent":"1.737325303s","remote":"127.0.0.1:55366","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:686 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-06T00:40:35.850344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.265257785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-06T00:40:35.850364Z","caller":"traceutil/trace.go:171","msg":"trace[688216701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:691; }","duration":"1.265299725s","start":"2026-02-06T00:40:34.585057Z","end":"2026-02-06T00:40:35.850356Z","steps":["trace[688216701] 'agreement among raft nodes before linearized reading'  (duration: 1.265229634s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:35.850384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:34.585041Z","time spent":"1.265338137s","remote":"127.0.0.1:55366","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-02-06T00:40:35.850488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257329788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:40:35.850505Z","caller":"traceutil/trace.go:171","msg":"trace[135669943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:691; }","duration":"1.257359298s","start":"2026-02-06T00:40:34.593141Z","end":"2026-02-06T00:40:35.8505Z","steps":["trace[135669943] 'agreement among raft nodes before linearized reading'  (duration: 1.257311487s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:35.850521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:34.593134Z","time spent":"1.257383348s","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:40:35.850637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.359049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:35.850654Z","caller":"traceutil/trace.go:171","msg":"trace[1546313072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"221.40234ms","start":"2026-02-06T00:40:35.629246Z","end":"2026-02-06T00:40:35.850649Z","steps":["trace[1546313072] 'agreement among raft nodes before linearized reading'  (duration: 221.37848ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:35.850747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18983889s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:40:35.850766Z","caller":"traceutil/trace.go:171","msg":"trace[396368156] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:691; }","duration":"1.189856741s","start":"2026-02-06T00:40:34.660903Z","end":"2026-02-06T00:40:35.850759Z","steps":["trace[396368156] 'agreement among raft nodes before linearized reading'  (duration: 1.18982631s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:35.850783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:34.660885Z","time spent":"1.189893221s","remote":"127.0.0.1:55546","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":"warn","ts":"2026-02-06T00:40:35.850859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22248156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:35.850876Z","caller":"traceutil/trace.go:171","msg":"trace[1873916046] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:691; }","duration":"1.222541762s","start":"2026-02-06T00:40:34.628329Z","end":"2026-02-06T00:40:35.850871Z","steps":["trace[1873916046] 'agreement among raft nodes before linearized reading'  (duration: 1.222517521s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:35.850892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:34.628318Z","time spent":"1.222569912s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"warn","ts":"2026-02-06T00:40:35.85099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257224165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-06T00:40:35.851008Z","caller":"traceutil/trace.go:171","msg":"trace[1048730795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:691; }","duration":"1.257252537s","start":"2026-02-06T00:40:34.593749Z","end":"2026-02-06T00:40:35.851002Z","steps":["trace[1048730795] 'agreement among raft nodes before linearized reading'  (duration: 1.257203155s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:35.851027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:34.593728Z","time spent":"1.257295807s","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-06T00:40:36.791293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.151241ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231954894 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:687 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:40:36.791386Z","caller":"traceutil/trace.go:171","msg":"trace[1722272715] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"929.440446ms","start":"2026-02-06T00:40:35.861928Z","end":"2026-02-06T00:40:36.791368Z","steps":["trace[1722272715] 'process raft request'  (duration: 579.144562ms)","trace[1722272715] 'compare'  (duration: 350.06942ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:36.791442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:35.861915Z","time spent":"929.499488ms","remote":"127.0.0.1:55366","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:687 > 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-02-06T00:40:36.959855Z","caller":"traceutil/trace.go:171","msg":"trace[1175332901] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"1.095786253s","start":"2026-02-06T00:40:35.864054Z","end":"2026-02-06T00:40:36.959841Z","steps":["trace[1175332901] 'process raft request'  (duration: 1.095703381s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:36.959951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:35.864045Z","time spent":"1.095856174s","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:689 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:40:36.959987Z","caller":"traceutil/trace.go:171","msg":"trace[1773726036] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:715; }","duration":"869.911527ms","start":"2026-02-06T00:40:36.090064Z","end":"2026-02-06T00:40:36.959976Z","steps":["trace[1773726036] 'read index received'  (duration: 351.016219ms)","trace[1773726036] 'applied index is now lower than readState.Index'  (duration: 518.894728ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:40:36.960078Z","caller":"traceutil/trace.go:171","msg":"trace[689420630] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"1.097046069s","start":"2026-02-06T00:40:35.863025Z","end":"2026-02-06T00:40:36.960072Z","steps":["trace[689420630] 'process raft request'  (duration: 1.087322244s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:36.96011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:35.863018Z","time spent":"1.09707482s","remote":"127.0.0.1:55366","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:688 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:40:36.960125Z","caller":"traceutil/trace.go:171","msg":"trace[1631823359] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"1.084676888s","start":"2026-02-06T00:40:35.87544Z","end":"2026-02-06T00:40:36.960117Z","steps":["trace[1631823359] 'process raft request'  (duration: 1.084375712s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:36.960168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:35.875424Z","time spent":"1.084717729s","remote":"127.0.0.1:55366","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:661 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-06T00:40:36.960271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.205524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-06T00:40:36.960289Z","caller":"traceutil/trace.go:171","msg":"trace[1681255981] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:695; }","duration":"870.246725ms","start":"2026-02-06T00:40:36.090037Z","end":"2026-02-06T00:40:36.960284Z","steps":["trace[1681255981] 'agreement among raft nodes before linearized reading'  (duration: 870.177643ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:36.960314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:36.090022Z","time spent":"870.287895ms","remote":"127.0.0.1:55366","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-02-06T00:40:36.960473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.919284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.244\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-06T00:40:36.960509Z","caller":"traceutil/trace.go:171","msg":"trace[804433711] range","detail":"{range_begin:/registry/masterleases/199.204.45.244; range_end:; response_count:1; response_revision:695; }","duration":"741.979324ms","start":"2026-02-06T00:40:36.218517Z","end":"2026-02-06T00:40:36.960496Z","steps":["trace[804433711] 'agreement among raft nodes before linearized reading'  (duration: 741.887682ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:36.960538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:36.21848Z","time spent":"742.052106ms","remote":"127.0.0.1:55124","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.244\" "}
{"level":"warn","ts":"2026-02-06T00:40:36.960543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.418466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:36.960568Z","caller":"traceutil/trace.go:171","msg":"trace[1409888969] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:695; }","duration":"392.472048ms","start":"2026-02-06T00:40:36.56809Z","end":"2026-02-06T00:40:36.960562Z","steps":["trace[1409888969] 'agreement among raft nodes before linearized reading'  (duration: 392.434417ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:36.960585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:36.568075Z","time spent":"392.505508ms","remote":"127.0.0.1:55350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-06T00:40:37.814201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.552899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:37.814257Z","caller":"traceutil/trace.go:171","msg":"trace[429007372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:697; }","duration":"191.64718ms","start":"2026-02-06T00:40:37.622599Z","end":"2026-02-06T00:40:37.814246Z","steps":["trace[429007372] 'range keys from in-memory index tree'  (duration: 191.480288ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:52.163612Z","caller":"traceutil/trace.go:171","msg":"trace[424653991] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"189.404466ms","start":"2026-02-06T00:40:51.974191Z","end":"2026-02-06T00:40:52.163595Z","steps":["trace[424653991] 'process raft request'  (duration: 189.272703ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:55.105703Z","caller":"traceutil/trace.go:171","msg":"trace[852275130] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"216.082551ms","start":"2026-02-06T00:40:54.889597Z","end":"2026-02-06T00:40:55.10568Z","steps":["trace[852275130] 'process raft request'  (duration: 215.812035ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:55.899819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.484933ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955060 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:745 > 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-02-06T00:40:55.89992Z","caller":"traceutil/trace.go:171","msg":"trace[250361770] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"753.602595ms","start":"2026-02-06T00:40:55.1463Z","end":"2026-02-06T00:40:55.899902Z","steps":["trace[250361770] 'process raft request'  (duration: 189.956738ms)","trace[250361770] 'compare'  (duration: 562.887181ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:55.900053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:55.14629Z","time spent":"753.665496ms","remote":"127.0.0.1:55366","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:745 > 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-02-06T00:40:56.155285Z","caller":"traceutil/trace.go:171","msg":"trace[605866562] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:777; }","duration":"840.702269ms","start":"2026-02-06T00:40:55.314562Z","end":"2026-02-06T00:40:56.155264Z","steps":["trace[605866562] 'read index received'  (duration: 21.713357ms)","trace[605866562] 'applied index is now lower than readState.Index'  (duration: 818.987962ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:40:56.155573Z","caller":"traceutil/trace.go:171","msg":"trace[1525954149] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"1.008361536s","start":"2026-02-06T00:40:55.1472Z","end":"2026-02-06T00:40:56.155562Z","steps":["trace[1525954149] 'process raft request'  (duration: 1.00765812s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:56.155686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:55.147194Z","time spent":"1.008407677s","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:747 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-06T00:40:56.155736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.790421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:56.155825Z","caller":"traceutil/trace.go:171","msg":"trace[111678456] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:752; }","duration":"619.935383ms","start":"2026-02-06T00:40:55.535868Z","end":"2026-02-06T00:40:56.155803Z","steps":["trace[111678456] 'agreement among raft nodes before linearized reading'  (duration: 619.76918ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:56.156434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.860575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:40:56.157146Z","caller":"traceutil/trace.go:171","msg":"trace[1551662072] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:752; }","duration":"842.594411ms","start":"2026-02-06T00:40:55.314535Z","end":"2026-02-06T00:40:56.15713Z","steps":["trace[1551662072] 'agreement among raft nodes before linearized reading'  (duration: 841.855275ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:56.157217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:55.314521Z","time spent":"842.680563ms","remote":"127.0.0.1:55280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"info","ts":"2026-02-06T00:40:56.15738Z","caller":"traceutil/trace.go:171","msg":"trace[1441417025] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"1.008703783s","start":"2026-02-06T00:40:55.148666Z","end":"2026-02-06T00:40:56.157369Z","steps":["trace[1441417025] 'process raft request'  (duration: 1.006556216s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:56.157435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:55.148659Z","time spent":"1.008743304s","remote":"127.0.0.1:55366","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:746 > 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-02-06T00:40:56.157785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.852172ms","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-02-06T00:40:56.157817Z","caller":"traceutil/trace.go:171","msg":"trace[2032709309] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:752; }","duration":"419.929155ms","start":"2026-02-06T00:40:55.737879Z","end":"2026-02-06T00:40:56.157808Z","steps":["trace[2032709309] 'agreement among raft nodes before linearized reading'  (duration: 419.874624ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:56.157845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:55.737857Z","time spent":"419.980806ms","remote":"127.0.0.1:55206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"warn","ts":"2026-02-06T00:40:56.158377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:55.535849Z","time spent":"620.016176ms","remote":"127.0.0.1:55346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-06T00:40:57.664136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037814406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:57.664226Z","caller":"traceutil/trace.go:171","msg":"trace[1026966399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"1.03798315s","start":"2026-02-06T00:40:56.626224Z","end":"2026-02-06T00:40:57.664207Z","steps":["trace[1026966399] 'range keys from in-memory index tree'  (duration: 1.037741215s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:57.664267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:56.626204Z","time spent":"1.038052152s","remote":"127.0.0.1:55118","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-02-06T00:40:57.664663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.115921ms","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-02-06T00:40:57.664761Z","caller":"traceutil/trace.go:171","msg":"trace[395098596] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:754; }","duration":"736.215543ms","start":"2026-02-06T00:40:56.928535Z","end":"2026-02-06T00:40:57.664751Z","steps":["trace[395098596] 'range keys from in-memory index tree'  (duration: 736.107471ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:57.666152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.103327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-06T00:40:57.666195Z","caller":"traceutil/trace.go:171","msg":"trace[43777748] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:754; }","duration":"554.21987ms","start":"2026-02-06T00:40:57.111963Z","end":"2026-02-06T00:40:57.666183Z","steps":["trace[43777748] 'range keys from in-memory index tree'  (duration: 553.961335ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:57.666227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:57.111945Z","time spent":"554.273461ms","remote":"127.0.0.1:55366","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":"info","ts":"2026-02-06T00:40:57.666875Z","caller":"traceutil/trace.go:171","msg":"trace[1556588698] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"514.541269ms","start":"2026-02-06T00:40:57.152321Z","end":"2026-02-06T00:40:57.666862Z","steps":["trace[1556588698] 'process raft request'  (duration: 514.450127ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:57.666954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:57.152301Z","time spent":"514.60612ms","remote":"127.0.0.1:55366","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:731 > 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-02-06T00:40:58.221479Z","caller":"traceutil/trace.go:171","msg":"trace[169021574] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"298.31852ms","start":"2026-02-06T00:40:57.92314Z","end":"2026-02-06T00:40:58.221458Z","steps":["trace[169021574] 'process raft request'  (duration: 298.172677ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:40:58.83176Z","caller":"traceutil/trace.go:171","msg":"trace[1257879565] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"603.267352ms","start":"2026-02-06T00:40:58.228476Z","end":"2026-02-06T00:40:58.831744Z","steps":["trace[1257879565] 'process raft request'  (duration: 603.156809ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:58.831859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:58.228456Z","time spent":"603.353073ms","remote":"127.0.0.1:55366","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:753 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-06T00:40:59.102213Z","caller":"traceutil/trace.go:171","msg":"trace[1776655814] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:786; }","duration":"732.644281ms","start":"2026-02-06T00:40:58.369554Z","end":"2026-02-06T00:40:59.102198Z","steps":["trace[1776655814] 'read index received'  (duration: 462.150409ms)","trace[1776655814] 'applied index is now lower than readState.Index'  (duration: 270.493412ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:40:59.10241Z","caller":"traceutil/trace.go:171","msg":"trace[400306049] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"873.707223ms","start":"2026-02-06T00:40:58.228696Z","end":"2026-02-06T00:40:59.102403Z","steps":["trace[400306049] 'process raft request'  (duration: 821.568081ms)","trace[400306049] 'compare'  (duration: 51.827525ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:40:59.102469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:58.228684Z","time spent":"873.742154ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:751 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-06T00:40:59.102656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.101591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:40:59.102675Z","caller":"traceutil/trace.go:171","msg":"trace[1570527338] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:760; }","duration":"733.125892ms","start":"2026-02-06T00:40:58.369544Z","end":"2026-02-06T00:40:59.10267Z","steps":["trace[1570527338] 'agreement among raft nodes before linearized reading'  (duration: 733.090951ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:59.10269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:58.36951Z","time spent":"733.176473ms","remote":"127.0.0.1:55500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"info","ts":"2026-02-06T00:40:59.10276Z","caller":"traceutil/trace.go:171","msg":"trace[1372688811] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"873.743633ms","start":"2026-02-06T00:40:58.22901Z","end":"2026-02-06T00:40:59.102753Z","steps":["trace[1372688811] 'process raft request'  (duration: 873.15283ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:40:59.102783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:40:58.228999Z","time spent":"873.770305ms","remote":"127.0.0.1:55366","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:752 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:41:16.406194Z","caller":"traceutil/trace.go:171","msg":"trace[1604280151] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"185.258207ms","start":"2026-02-06T00:41:16.220916Z","end":"2026-02-06T00:41:16.406174Z","steps":["trace[1604280151] 'read index received'  (duration: 185.084293ms)","trace[1604280151] 'applied index is now lower than readState.Index'  (duration: 172.844µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:16.406303Z","caller":"traceutil/trace.go:171","msg":"trace[2044471636] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"512.512657ms","start":"2026-02-06T00:41:15.893781Z","end":"2026-02-06T00:41:16.406294Z","steps":["trace[2044471636] 'process raft request'  (duration: 512.234691ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:16.406387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:15.89376Z","time spent":"512.563559ms","remote":"127.0.0.1:55366","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:851 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-06T00:41:16.40655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.618925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.244\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-06T00:41:16.406598Z","caller":"traceutil/trace.go:171","msg":"trace[472043407] range","detail":"{range_begin:/registry/masterleases/199.204.45.244; range_end:; response_count:1; response_revision:856; }","duration":"185.729747ms","start":"2026-02-06T00:41:16.220855Z","end":"2026-02-06T00:41:16.406585Z","steps":["trace[472043407] 'agreement among raft nodes before linearized reading'  (duration: 185.638675ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:16.922334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:16.407639Z","time spent":"514.691906ms","remote":"127.0.0.1:55124","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-06T00:41:17.000129Z","caller":"traceutil/trace.go:171","msg":"trace[1291962159] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"589.248983ms","start":"2026-02-06T00:41:16.410865Z","end":"2026-02-06T00:41:17.000114Z","steps":["trace[1291962159] 'process raft request'  (duration: 588.61438ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:17.000213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:16.410851Z","time spent":"589.316864ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:852 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:41:17.000287Z","caller":"traceutil/trace.go:171","msg":"trace[2135964318] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:891; }","duration":"374.509217ms","start":"2026-02-06T00:41:16.625762Z","end":"2026-02-06T00:41:17.000272Z","steps":["trace[2135964318] 'read index received'  (duration: 296.892924ms)","trace[2135964318] 'applied index is now lower than readState.Index'  (duration: 77.615513ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:17.000416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.640082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:17.000438Z","caller":"traceutil/trace.go:171","msg":"trace[654483474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:858; }","duration":"374.705793ms","start":"2026-02-06T00:41:16.625726Z","end":"2026-02-06T00:41:17.000432Z","steps":["trace[654483474] 'agreement among raft nodes before linearized reading'  (duration: 374.657791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:17.000462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:16.625626Z","time spent":"374.828765ms","remote":"127.0.0.1:55118","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-02-06T00:41:17.896248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.249496ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955325 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:855 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:17.896317Z","caller":"traceutil/trace.go:171","msg":"trace[1978826874] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"448.75637ms","start":"2026-02-06T00:41:17.447548Z","end":"2026-02-06T00:41:17.896305Z","steps":["trace[1978826874] 'process raft request'  (duration: 210.392152ms)","trace[1978826874] 'compare'  (duration: 237.95441ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:17.89635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:17.447529Z","time spent":"448.806261ms","remote":"127.0.0.1:55366","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:855 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:41:19.139272Z","caller":"traceutil/trace.go:171","msg":"trace[800643042] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:898; }","duration":"116.153574ms","start":"2026-02-06T00:41:19.023102Z","end":"2026-02-06T00:41:19.139256Z","steps":["trace[800643042] 'read index received'  (duration: 116.021531ms)","trace[800643042] 'applied index is now lower than readState.Index'  (duration: 131.423µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:19.139422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.311337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:41:19.139439Z","caller":"traceutil/trace.go:171","msg":"trace[1769218341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:864; }","duration":"116.366109ms","start":"2026-02-06T00:41:19.023067Z","end":"2026-02-06T00:41:19.139433Z","steps":["trace[1769218341] 'agreement among raft nodes before linearized reading'  (duration: 116.265407ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:19.13962Z","caller":"traceutil/trace.go:171","msg":"trace[891043811] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"134.395034ms","start":"2026-02-06T00:41:19.005219Z","end":"2026-02-06T00:41:19.139614Z","steps":["trace[891043811] 'process raft request'  (duration: 133.959555ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:20.26686Z","caller":"traceutil/trace.go:171","msg":"trace[1371495116] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"362.618566ms","start":"2026-02-06T00:41:19.904225Z","end":"2026-02-06T00:41:20.266844Z","steps":["trace[1371495116] 'process raft request'  (duration: 362.520184ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:20.266959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:19.904203Z","time spent":"362.706097ms","remote":"127.0.0.1:55366","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:861 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:41:27.386343Z","caller":"traceutil/trace.go:171","msg":"trace[1123552761] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"174.009407ms","start":"2026-02-06T00:41:27.21232Z","end":"2026-02-06T00:41:27.38633Z","steps":["trace[1123552761] 'read index received'  (duration: 173.894115ms)","trace[1123552761] 'applied index is now lower than readState.Index'  (duration: 114.732µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:27.386468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.13934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-06T00:41:27.386483Z","caller":"traceutil/trace.go:171","msg":"trace[1225940774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:886; }","duration":"174.190381ms","start":"2026-02-06T00:41:27.212289Z","end":"2026-02-06T00:41:27.386479Z","steps":["trace[1225940774] 'agreement among raft nodes before linearized reading'  (duration: 174.093649ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:27.386628Z","caller":"traceutil/trace.go:171","msg":"trace[133659933] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"221.713113ms","start":"2026-02-06T00:41:27.16491Z","end":"2026-02-06T00:41:27.386623Z","steps":["trace[133659933] 'process raft request'  (duration: 221.347026ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:29.025513Z","caller":"traceutil/trace.go:171","msg":"trace[928309464] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"250.422945ms","start":"2026-02-06T00:41:28.775068Z","end":"2026-02-06T00:41:29.025491Z","steps":["trace[928309464] 'process raft request'  (duration: 250.240341ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:31.918689Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197500231955427,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-06T00:41:32.040679Z","caller":"traceutil/trace.go:171","msg":"trace[262556116] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"622.993082ms","start":"2026-02-06T00:41:31.41767Z","end":"2026-02-06T00:41:32.040663Z","steps":["trace[262556116] 'process raft request'  (duration: 622.89809ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:32.040772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:31.417659Z","time spent":"623.064653ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:892 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:41:32.041056Z","caller":"traceutil/trace.go:171","msg":"trace[469208037] linearizableReadLoop","detail":"{readStateIndex:935; appliedIndex:935; }","duration":"623.276669ms","start":"2026-02-06T00:41:31.417774Z","end":"2026-02-06T00:41:32.041051Z","steps":["trace[469208037] 'read index received'  (duration: 623.274439ms)","trace[469208037] 'applied index is now lower than readState.Index'  (duration: 1.91µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:32.041138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.494924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:41:32.041166Z","caller":"traceutil/trace.go:171","msg":"trace[117399435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:898; }","duration":"486.552696ms","start":"2026-02-06T00:41:31.554595Z","end":"2026-02-06T00:41:32.041148Z","steps":["trace[117399435] 'agreement among raft nodes before linearized reading'  (duration: 486.489394ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:32.041179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:31.554563Z","time spent":"486.613197ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:41:32.041281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.503673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:41:32.041294Z","caller":"traceutil/trace.go:171","msg":"trace[2116604781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:898; }","duration":"623.526094ms","start":"2026-02-06T00:41:31.417763Z","end":"2026-02-06T00:41:32.041289Z","steps":["trace[2116604781] 'agreement among raft nodes before linearized reading'  (duration: 623.484843ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:32.041306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:31.417759Z","time spent":"623.543564ms","remote":"127.0.0.1:55366","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-02-06T00:41:32.041372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.149176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:32.041388Z","caller":"traceutil/trace.go:171","msg":"trace[1809200738] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:898; }","duration":"232.189997ms","start":"2026-02-06T00:41:31.809193Z","end":"2026-02-06T00:41:32.041383Z","steps":["trace[1809200738] 'agreement among raft nodes before linearized reading'  (duration: 232.157076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:32.041466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.328079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:32.041479Z","caller":"traceutil/trace.go:171","msg":"trace[82380949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"416.359981ms","start":"2026-02-06T00:41:31.625115Z","end":"2026-02-06T00:41:32.041475Z","steps":["trace[82380949] 'agreement among raft nodes before linearized reading'  (duration: 416.33751ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:32.041491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:31.625104Z","time spent":"416.383941ms","remote":"127.0.0.1:55104","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-02-06T00:41:32.041559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.511521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:32.041571Z","caller":"traceutil/trace.go:171","msg":"trace[292715331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"445.547712ms","start":"2026-02-06T00:41:31.596019Z","end":"2026-02-06T00:41:32.041566Z","steps":["trace[292715331] 'agreement among raft nodes before linearized reading'  (duration: 445.531561ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:32.041581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:31.596004Z","time spent":"445.574393ms","remote":"127.0.0.1:55118","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-02-06T00:41:32.267243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.985208ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955431 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:893 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:32.26734Z","caller":"traceutil/trace.go:171","msg":"trace[727314923] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"217.260748ms","start":"2026-02-06T00:41:32.05007Z","end":"2026-02-06T00:41:32.26733Z","steps":["trace[727314923] 'process raft request'  (duration: 217.233847ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:32.267545Z","caller":"traceutil/trace.go:171","msg":"trace[1151381653] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"219.487355ms","start":"2026-02-06T00:41:32.048052Z","end":"2026-02-06T00:41:32.267539Z","steps":["trace[1151381653] 'process raft request'  (duration: 105.15319ms)","trace[1151381653] 'compare'  (duration: 113.923987ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:34.35873Z","caller":"traceutil/trace.go:171","msg":"trace[30890066] linearizableReadLoop","detail":"{readStateIndex:941; appliedIndex:940; }","duration":"285.575854ms","start":"2026-02-06T00:41:34.073127Z","end":"2026-02-06T00:41:34.358703Z","steps":["trace[30890066] 'read index received'  (duration: 285.3975ms)","trace[30890066] 'applied index is now lower than readState.Index'  (duration: 177.524µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:34.359073Z","caller":"traceutil/trace.go:171","msg":"trace[1587414293] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"303.600727ms","start":"2026-02-06T00:41:34.055441Z","end":"2026-02-06T00:41:34.359042Z","steps":["trace[1587414293] 'process raft request'  (duration: 303.138868ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:34.359251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:34.055427Z","time spent":"303.740101ms","remote":"127.0.0.1:55366","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:898 > 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-02-06T00:41:34.359429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.297729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:41:34.359465Z","caller":"traceutil/trace.go:171","msg":"trace[145115087] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:903; }","duration":"286.365831ms","start":"2026-02-06T00:41:34.073084Z","end":"2026-02-06T00:41:34.35945Z","steps":["trace[145115087] 'agreement among raft nodes before linearized reading'  (duration: 286.284289ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:34.559889Z","caller":"traceutil/trace.go:171","msg":"trace[508671324] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"190.924697ms","start":"2026-02-06T00:41:34.368945Z","end":"2026-02-06T00:41:34.559869Z","steps":["trace[508671324] 'process raft request'  (duration: 162.025461ms)","trace[508671324] 'compare'  (duration: 28.636531ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:34.574453Z","caller":"traceutil/trace.go:171","msg":"trace[1311835942] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"203.812232ms","start":"2026-02-06T00:41:34.370629Z","end":"2026-02-06T00:41:34.574441Z","steps":["trace[1311835942] 'process raft request'  (duration: 203.535517ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:34.575642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.798247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-06T00:41:34.576409Z","caller":"traceutil/trace.go:171","msg":"trace[1377675316] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:905; }","duration":"155.607186ms","start":"2026-02-06T00:41:34.420792Z","end":"2026-02-06T00:41:34.576399Z","steps":["trace[1377675316] 'agreement among raft nodes before linearized reading'  (duration: 154.736076ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:34.575487Z","caller":"traceutil/trace.go:171","msg":"trace[196991638] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:941; }","duration":"153.461099ms","start":"2026-02-06T00:41:34.420824Z","end":"2026-02-06T00:41:34.574285Z","steps":["trace[196991638] 'read index received'  (duration: 110.158126ms)","trace[196991638] 'applied index is now lower than readState.Index'  (duration: 43.301963ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:36.557942Z","caller":"traceutil/trace.go:171","msg":"trace[1387801520] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"154.88661ms","start":"2026-02-06T00:41:36.40304Z","end":"2026-02-06T00:41:36.557927Z","steps":["trace[1387801520] 'process raft request'  (duration: 94.055714ms)","trace[1387801520] 'compare'  (duration: 60.434848ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:36.721334Z","caller":"traceutil/trace.go:171","msg":"trace[97836406] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"142.125147ms","start":"2026-02-06T00:41:36.57919Z","end":"2026-02-06T00:41:36.721315Z","steps":["trace[97836406] 'read index received'  (duration: 111.878263ms)","trace[97836406] 'applied index is now lower than readState.Index'  (duration: 30.246104ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:36.721527Z","caller":"traceutil/trace.go:171","msg":"trace[548025571] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"155.507512ms","start":"2026-02-06T00:41:36.56601Z","end":"2026-02-06T00:41:36.721518Z","steps":["trace[548025571] 'process raft request'  (duration: 125.098055ms)","trace[548025571] 'compare'  (duration: 30.140532ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:36.721742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.539206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:41:36.721768Z","caller":"traceutil/trace.go:171","msg":"trace[2118660928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:914; }","duration":"142.593497ms","start":"2026-02-06T00:41:36.579167Z","end":"2026-02-06T00:41:36.721761Z","steps":["trace[2118660928] 'agreement among raft nodes before linearized reading'  (duration: 142.493764ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:36.721913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.264554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-06T00:41:36.721936Z","caller":"traceutil/trace.go:171","msg":"trace[1732721851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:914; }","duration":"129.311375ms","start":"2026-02-06T00:41:36.592618Z","end":"2026-02-06T00:41:36.72193Z","steps":["trace[1732721851] 'agreement among raft nodes before linearized reading'  (duration: 129.246584ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:36.72228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.242329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-02-06T00:41:36.7223Z","caller":"traceutil/trace.go:171","msg":"trace[1373177712] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:914; }","duration":"126.27294ms","start":"2026-02-06T00:41:36.596021Z","end":"2026-02-06T00:41:36.722294Z","steps":["trace[1373177712] 'agreement among raft nodes before linearized reading'  (duration: 126.240379ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:37.017569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.966436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955475 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:907 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:37.017909Z","caller":"traceutil/trace.go:171","msg":"trace[2041156360] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"288.736681ms","start":"2026-02-06T00:41:36.729158Z","end":"2026-02-06T00:41:37.017894Z","steps":["trace[2041156360] 'process raft request'  (duration: 183.395977ms)","trace[2041156360] 'compare'  (duration: 104.903055ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:37.017996Z","caller":"traceutil/trace.go:171","msg":"trace[1405904605] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"288.143929ms","start":"2026-02-06T00:41:36.729846Z","end":"2026-02-06T00:41:37.01799Z","steps":["trace[1405904605] 'process raft request'  (duration: 287.780191ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:43.218557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.435909ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955541 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:937 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:43.218653Z","caller":"traceutil/trace.go:171","msg":"trace[1307961628] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:991; }","duration":"400.164975ms","start":"2026-02-06T00:41:42.818473Z","end":"2026-02-06T00:41:43.218638Z","steps":["trace[1307961628] 'read index received'  (duration: 40.520272ms)","trace[1307961628] 'applied index is now lower than readState.Index'  (duration: 359.643653ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:43.218844Z","caller":"traceutil/trace.go:171","msg":"trace[13630846] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"409.131316ms","start":"2026-02-06T00:41:42.809699Z","end":"2026-02-06T00:41:43.21883Z","steps":["trace[13630846] 'process raft request'  (duration: 49.352041ms)","trace[13630846] 'compare'  (duration: 359.086759ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:43.218905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:42.809682Z","time spent":"409.190887ms","remote":"127.0.0.1:55366","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:937 > 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-02-06T00:41:43.219075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.598634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:43.219108Z","caller":"traceutil/trace.go:171","msg":"trace[1654903337] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:952; }","duration":"400.653966ms","start":"2026-02-06T00:41:42.818442Z","end":"2026-02-06T00:41:43.219096Z","steps":["trace[1654903337] 'agreement among raft nodes before linearized reading'  (duration: 400.602154ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:43.219137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:42.818426Z","time spent":"400.704816ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-06T00:41:43.21935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.237556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:41:43.219379Z","caller":"traceutil/trace.go:171","msg":"trace[1273623512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:952; }","duration":"300.292377ms","start":"2026-02-06T00:41:42.919077Z","end":"2026-02-06T00:41:43.219369Z","steps":["trace[1273623512] 'agreement among raft nodes before linearized reading'  (duration: 300.192765ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:43.219406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:42.919062Z","time spent":"300.337468ms","remote":"127.0.0.1:55366","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-02-06T00:41:43.219662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.802315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-02-06T00:41:43.219692Z","caller":"traceutil/trace.go:171","msg":"trace[326911700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"175.841736ms","start":"2026-02-06T00:41:43.043841Z","end":"2026-02-06T00:41:43.219683Z","steps":["trace[326911700] 'agreement among raft nodes before linearized reading'  (duration: 175.761294ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:43.219854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.776096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-06T00:41:43.21988Z","caller":"traceutil/trace.go:171","msg":"trace[676217151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:952; }","duration":"177.822928ms","start":"2026-02-06T00:41:43.042049Z","end":"2026-02-06T00:41:43.219872Z","steps":["trace[676217151] 'agreement among raft nodes before linearized reading'  (duration: 177.749156ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:41:43.46069Z","caller":"traceutil/trace.go:171","msg":"trace[1445506968] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"237.736825ms","start":"2026-02-06T00:41:43.222932Z","end":"2026-02-06T00:41:43.460668Z","steps":["trace[1445506968] 'process raft request'  (duration: 204.221441ms)","trace[1445506968] 'compare'  (duration: 33.238358ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:44.032023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.005136ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955545 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:942 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:44.032197Z","caller":"traceutil/trace.go:171","msg":"trace[1107278397] linearizableReadLoop","detail":"{readStateIndex:995; appliedIndex:992; }","duration":"801.637568ms","start":"2026-02-06T00:41:43.230544Z","end":"2026-02-06T00:41:44.032181Z","steps":["trace[1107278397] 'read index received'  (duration: 196.618169ms)","trace[1107278397] 'applied index is now lower than readState.Index'  (duration: 605.018409ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:44.032282Z","caller":"traceutil/trace.go:171","msg":"trace[1302131165] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"805.842628ms","start":"2026-02-06T00:41:43.226429Z","end":"2026-02-06T00:41:44.032272Z","steps":["trace[1302131165] 'process raft request'  (duration: 341.501246ms)","trace[1302131165] 'compare'  (duration: 463.890233ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:44.032336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:43.226413Z","time spent":"805.892869ms","remote":"127.0.0.1:55366","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:942 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-06T00:41:44.032346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.781151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:44.032415Z","caller":"traceutil/trace.go:171","msg":"trace[720856632] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:955; }","duration":"801.872443ms","start":"2026-02-06T00:41:43.230524Z","end":"2026-02-06T00:41:44.032396Z","steps":["trace[720856632] 'agreement among raft nodes before linearized reading'  (duration: 801.767651ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:44.032454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:43.230516Z","time spent":"801.929984ms","remote":"127.0.0.1:55190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-02-06T00:41:44.032545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.158519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:44.032577Z","caller":"traceutil/trace.go:171","msg":"trace[618183524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:955; }","duration":"403.21246ms","start":"2026-02-06T00:41:43.629354Z","end":"2026-02-06T00:41:44.032566Z","steps":["trace[618183524] 'agreement among raft nodes before linearized reading'  (duration: 403.164839ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:44.032608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:43.629338Z","time spent":"403.265361ms","remote":"127.0.0.1:55118","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-02-06T00:41:44.03295Z","caller":"traceutil/trace.go:171","msg":"trace[798173720] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"804.874057ms","start":"2026-02-06T00:41:43.228066Z","end":"2026-02-06T00:41:44.03294Z","steps":["trace[798173720] 'process raft request'  (duration: 804.0425ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:44.033016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:43.228058Z","time spent":"804.927848ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:944 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-06T00:41:44.343427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.668022ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955550 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:406 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:44.343494Z","caller":"traceutil/trace.go:171","msg":"trace[1471443967] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"306.638122ms","start":"2026-02-06T00:41:44.036844Z","end":"2026-02-06T00:41:44.343483Z","steps":["trace[1471443967] 'process raft request'  (duration: 100.865429ms)","trace[1471443967] 'compare'  (duration: 205.364375ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:44.34353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:44.036828Z","time spent":"306.690164ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"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:406 >> failure:<>"}
{"level":"warn","ts":"2026-02-06T00:41:45.01368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.424359ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955552 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.1891817d73acdefa\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.1891817d73acdefa\" value_size:692 lease:9142197500231955243 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:45.013795Z","caller":"traceutil/trace.go:171","msg":"trace[1436998186] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"664.534697ms","start":"2026-02-06T00:41:44.349241Z","end":"2026-02-06T00:41:45.013775Z","steps":["trace[1436998186] 'process raft request'  (duration: 555.922994ms)","trace[1436998186] 'compare'  (duration: 108.243415ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:45.013847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:44.349232Z","time spent":"664.593128ms","remote":"127.0.0.1:55178","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.1891817d73acdefa\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.1891817d73acdefa\" value_size:692 lease:9142197500231955243 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:41:45.109626Z","caller":"traceutil/trace.go:171","msg":"trace[474252138] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:996; }","duration":"514.114154ms","start":"2026-02-06T00:41:44.595496Z","end":"2026-02-06T00:41:45.109611Z","steps":["trace[474252138] 'read index received'  (duration: 309.675488ms)","trace[474252138] 'applied index is now lower than readState.Index'  (duration: 204.437746ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:41:45.109855Z","caller":"traceutil/trace.go:171","msg":"trace[596189828] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"757.567221ms","start":"2026-02-06T00:41:44.352276Z","end":"2026-02-06T00:41:45.109843Z","steps":["trace[596189828] 'process raft request'  (duration: 757.240984ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:45.110064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.799795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:41:45.110157Z","caller":"traceutil/trace.go:171","msg":"trace[1643111294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:958; }","duration":"465.928719ms","start":"2026-02-06T00:41:44.644205Z","end":"2026-02-06T00:41:45.110134Z","steps":["trace[1643111294] 'agreement among raft nodes before linearized reading'  (duration: 465.790976ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:45.110221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:44.644195Z","time spent":"466.0113ms","remote":"127.0.0.1:55118","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-02-06T00:41:45.110556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.038463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-06T00:41:45.11065Z","caller":"traceutil/trace.go:171","msg":"trace[1695938280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:958; }","duration":"515.136535ms","start":"2026-02-06T00:41:44.59546Z","end":"2026-02-06T00:41:45.110596Z","steps":["trace[1695938280] 'agreement among raft nodes before linearized reading'  (duration: 514.978812ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:45.1107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:44.595443Z","time spent":"515.246187ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-06T00:41:45.111825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:44.35227Z","time spent":"757.682553ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:956 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-02-06T00:41:50.390498Z","caller":"traceutil/trace.go:171","msg":"trace[990937127] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"325.985283ms","start":"2026-02-06T00:41:50.064495Z","end":"2026-02-06T00:41:50.39048Z","steps":["trace[990937127] 'process raft request'  (duration: 325.869361ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:50.390616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:50.064481Z","time spent":"326.079285ms","remote":"127.0.0.1:55366","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:975 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-06T00:41:50.736438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.225283ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231955609 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:41:50.736518Z","caller":"traceutil/trace.go:171","msg":"trace[6548876] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1022; }","duration":"616.808133ms","start":"2026-02-06T00:41:50.119698Z","end":"2026-02-06T00:41:50.736506Z","steps":["trace[6548876] 'read index received'  (duration: 271.246157ms)","trace[6548876] 'applied index is now lower than readState.Index'  (duration: 345.560946ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:50.736608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.910346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-02-06T00:41:50.736625Z","caller":"traceutil/trace.go:171","msg":"trace[1296052945] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:982; }","duration":"616.948866ms","start":"2026-02-06T00:41:50.11967Z","end":"2026-02-06T00:41:50.736619Z","steps":["trace[1296052945] 'agreement among raft nodes before linearized reading'  (duration: 616.868134ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:41:50.736646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:50.119655Z","time spent":"616.985826ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-02-06T00:41:50.736677Z","caller":"traceutil/trace.go:171","msg":"trace[359558132] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"671.400675ms","start":"2026-02-06T00:41:50.065244Z","end":"2026-02-06T00:41:50.736645Z","steps":["trace[359558132] 'process raft request'  (duration: 533.874066ms)","trace[359558132] 'compare'  (duration: 137.129741ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:41:50.736814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:41:50.065225Z","time spent":"671.513507ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-06T00:44:50.928315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.210699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-06T00:44:50.92932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.734999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2723"}
{"level":"info","ts":"2026-02-06T00:44:50.929396Z","caller":"traceutil/trace.go:171","msg":"trace[1431589086] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1760; }","duration":"101.858921ms","start":"2026-02-06T00:44:50.827519Z","end":"2026-02-06T00:44:50.929378Z","steps":["trace[1431589086] 'range keys from in-memory index tree'  (duration: 101.476563ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:44:50.929891Z","caller":"traceutil/trace.go:171","msg":"trace[658984221] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1760; }","duration":"168.332442ms","start":"2026-02-06T00:44:50.760045Z","end":"2026-02-06T00:44:50.928378Z","steps":["trace[658984221] 'count revisions from in-memory index tree'  (duration: 168.160049ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:44:58.597829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.350619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-02-06T00:44:58.597893Z","caller":"traceutil/trace.go:171","msg":"trace[2002650610] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1795; }","duration":"157.445011ms","start":"2026-02-06T00:44:58.440433Z","end":"2026-02-06T00:44:58.597878Z","steps":["trace[2002650610] 'range keys from in-memory index tree'  (duration: 157.154015ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:44:58.83463Z","caller":"traceutil/trace.go:171","msg":"trace[35784665] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"208.712669ms","start":"2026-02-06T00:44:58.625889Z","end":"2026-02-06T00:44:58.834602Z","steps":["trace[35784665] 'read index received'  (duration: 68.431872ms)","trace[35784665] 'applied index is now lower than readState.Index'  (duration: 140.279547ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:44:58.835091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.179749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:44:58.835156Z","caller":"traceutil/trace.go:171","msg":"trace[895200841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1797; }","duration":"209.281022ms","start":"2026-02-06T00:44:58.625859Z","end":"2026-02-06T00:44:58.83514Z","steps":["trace[895200841] 'agreement among raft nodes before linearized reading'  (duration: 209.169578ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:44:58.835511Z","caller":"traceutil/trace.go:171","msg":"trace[63651853] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"231.033254ms","start":"2026-02-06T00:44:58.604453Z","end":"2026-02-06T00:44:58.835486Z","steps":["trace[63651853] 'process raft request'  (duration: 155.754016ms)","trace[63651853] 'compare'  (duration: 74.056781ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:44:58.836393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.420621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:44:58.836452Z","caller":"traceutil/trace.go:171","msg":"trace[924905008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1797; }","duration":"100.511594ms","start":"2026-02-06T00:44:58.735923Z","end":"2026-02-06T00:44:58.836435Z","steps":["trace[924905008] 'agreement among raft nodes before linearized reading'  (duration: 100.34803ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:44:59.101254Z","caller":"traceutil/trace.go:171","msg":"trace[1987712240] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"257.75049ms","start":"2026-02-06T00:44:58.843479Z","end":"2026-02-06T00:44:59.101229Z","steps":["trace[1987712240] 'process raft request'  (duration: 180.977391ms)","trace[1987712240] 'compare'  (duration: 76.181007ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:45:02.100183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.087439ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142197500231957712 > lease_revoke:<id:7edf9c3063ca3c05>","response":"size:27"}
{"level":"info","ts":"2026-02-06T00:45:02.100556Z","caller":"traceutil/trace.go:171","msg":"trace[595494302] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1891; }","duration":"474.698514ms","start":"2026-02-06T00:45:01.625825Z","end":"2026-02-06T00:45:02.100524Z","steps":["trace[595494302] 'read index received'  (duration: 92.193046ms)","trace[595494302] 'applied index is now lower than readState.Index'  (duration: 382.500608ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:45:02.100826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.997941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:45:02.100868Z","caller":"traceutil/trace.go:171","msg":"trace[1565650773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1812; }","duration":"475.089493ms","start":"2026-02-06T00:45:01.625768Z","end":"2026-02-06T00:45:02.100857Z","steps":["trace[1565650773] 'agreement among raft nodes before linearized reading'  (duration: 474.994801ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:02.100595Z","caller":"traceutil/trace.go:171","msg":"trace[1095285821] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"240.381352ms","start":"2026-02-06T00:45:01.860195Z","end":"2026-02-06T00:45:02.100576Z","steps":["trace[1095285821] 'process raft request'  (duration: 240.090786ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:02.10102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:01.625746Z","time spent":"475.260116ms","remote":"127.0.0.1:55118","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-02-06T00:45:02.102623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.650282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-06T00:45:02.102815Z","caller":"traceutil/trace.go:171","msg":"trace[206194049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1812; }","duration":"293.857516ms","start":"2026-02-06T00:45:01.808849Z","end":"2026-02-06T00:45:02.102707Z","steps":["trace[206194049] 'agreement among raft nodes before linearized reading'  (duration: 292.506057ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:02.327193Z","caller":"traceutil/trace.go:171","msg":"trace[503470257] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"218.64154ms","start":"2026-02-06T00:45:02.108527Z","end":"2026-02-06T00:45:02.327168Z","steps":["trace[503470257] 'process raft request'  (duration: 216.713009ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:02.581617Z","caller":"traceutil/trace.go:171","msg":"trace[1847883484] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"242.818561ms","start":"2026-02-06T00:45:02.338777Z","end":"2026-02-06T00:45:02.581596Z","steps":["trace[1847883484] 'process raft request'  (duration: 184.111841ms)","trace[1847883484] 'compare'  (duration: 58.264511ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:45:03.166904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.329379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:45:03.167391Z","caller":"traceutil/trace.go:171","msg":"trace[1696805326] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1815; }","duration":"441.85743ms","start":"2026-02-06T00:45:02.725519Z","end":"2026-02-06T00:45:03.167377Z","steps":["trace[1696805326] 'count revisions from in-memory index tree'  (duration: 441.138656ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:03.167605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:02.7255Z","time spent":"442.091254ms","remote":"127.0.0.1:55496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-06T00:45:03.167744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.062755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-06T00:45:03.168039Z","caller":"traceutil/trace.go:171","msg":"trace[880624663] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1815; }","duration":"297.402802ms","start":"2026-02-06T00:45:02.870619Z","end":"2026-02-06T00:45:03.168022Z","steps":["trace[880624663] 'range keys from in-memory index tree'  (duration: 296.929102ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:07.451302Z","caller":"traceutil/trace.go:171","msg":"trace[43192480] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"254.746502ms","start":"2026-02-06T00:45:07.19651Z","end":"2026-02-06T00:45:07.451257Z","steps":["trace[43192480] 'process raft request'  (duration: 254.62261ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:07.451494Z","caller":"traceutil/trace.go:171","msg":"trace[1747382574] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1919; }","duration":"253.434074ms","start":"2026-02-06T00:45:07.19792Z","end":"2026-02-06T00:45:07.451354Z","steps":["trace[1747382574] 'read index received'  (duration: 253.424844ms)","trace[1747382574] 'applied index is now lower than readState.Index'  (duration: 7.76µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:45:07.451924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.976566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:45:07.452844Z","caller":"traceutil/trace.go:171","msg":"trace[1544654355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1837; }","duration":"254.922576ms","start":"2026-02-06T00:45:07.197903Z","end":"2026-02-06T00:45:07.452826Z","steps":["trace[1544654355] 'agreement among raft nodes before linearized reading'  (duration: 253.802512ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:07.457043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.959298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:45:07.457133Z","caller":"traceutil/trace.go:171","msg":"trace[514949518] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1838; }","duration":"143.0674ms","start":"2026-02-06T00:45:07.314042Z","end":"2026-02-06T00:45:07.457109Z","steps":["trace[514949518] 'agreement among raft nodes before linearized reading'  (duration: 142.965488ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:07.457323Z","caller":"traceutil/trace.go:171","msg":"trace[1946104625] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"258.50771ms","start":"2026-02-06T00:45:07.198807Z","end":"2026-02-06T00:45:07.457314Z","steps":["trace[1946104625] 'process raft request'  (duration: 258.118532ms)"],"step_count":1}