{"level":"warn","ts":"2026-02-20T16:04:25.129848Z","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-20T16:04:25.129927Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.41: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.41:2380","--initial-cluster=instance=https://199.204.45.41:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.41:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.41: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-20T16:04:25.129995Z","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-20T16:04:25.130008Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.41:2380"]}
{"level":"info","ts":"2026-02-20T16:04:25.130024Z","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-20T16:04:25.130643Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.41:2379"]}
{"level":"info","ts":"2026-02-20T16:04:25.130735Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.41:2380"],"listen-peer-urls":["https://199.204.45.41:2380"],"advertise-client-urls":["https://199.204.45.41:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.41:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.41: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-20T16:04:25.136587Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.399724ms"}
{"level":"info","ts":"2026-02-20T16:04:25.146975Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"17dd22a2661aae79","cluster-id":"c5133f40b27eeb3"}
{"level":"info","ts":"2026-02-20T16:04:25.147188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-20T16:04:25.147254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 became follower at term 0"}
{"level":"info","ts":"2026-02-20T16:04:25.147312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 17dd22a2661aae79 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-20T16:04:25.147361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 became follower at term 1"}
{"level":"info","ts":"2026-02-20T16:04:25.147437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 switched to configuration voters=(1719568713618468473)"}
{"level":"warn","ts":"2026-02-20T16:04:25.153373Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-20T16:04:25.154727Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-20T16:04:25.15622Z","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-20T16:04:25.15869Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"17dd22a2661aae79","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-20T16:04:25.15893Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"17dd22a2661aae79","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-20T16:04:25.159073Z","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-20T16:04:25.159168Z","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-20T16:04:25.15919Z","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-20T16:04:25.159742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 switched to configuration voters=(1719568713618468473)"}
{"level":"info","ts":"2026-02-20T16:04:25.160386Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c5133f40b27eeb3","local-member-id":"17dd22a2661aae79","added-peer-id":"17dd22a2661aae79","added-peer-peer-urls":["https://199.204.45.41:2380"]}
{"level":"info","ts":"2026-02-20T16:04:25.163216Z","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-20T16:04:25.163383Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"17dd22a2661aae79","initial-advertise-peer-urls":["https://199.204.45.41:2380"],"listen-peer-urls":["https://199.204.45.41:2380"],"advertise-client-urls":["https://199.204.45.41:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.41:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-20T16:04:25.163416Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-20T16:04:25.163805Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.41:2380"}
{"level":"info","ts":"2026-02-20T16:04:25.163848Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.41:2380"}
{"level":"info","ts":"2026-02-20T16:04:25.347638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-20T16:04:25.347698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-20T16:04:25.347739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 received MsgPreVoteResp from 17dd22a2661aae79 at term 1"}
{"level":"info","ts":"2026-02-20T16:04:25.347761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 became candidate at term 2"}
{"level":"info","ts":"2026-02-20T16:04:25.347772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 received MsgVoteResp from 17dd22a2661aae79 at term 2"}
{"level":"info","ts":"2026-02-20T16:04:25.347788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17dd22a2661aae79 became leader at term 2"}
{"level":"info","ts":"2026-02-20T16:04:25.347801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 17dd22a2661aae79 elected leader 17dd22a2661aae79 at term 2"}
{"level":"info","ts":"2026-02-20T16:04:25.348666Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"17dd22a2661aae79","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.41:2379]}","request-path":"/0/members/17dd22a2661aae79/attributes","cluster-id":"c5133f40b27eeb3","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-20T16:04:25.348735Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T16:04:25.348693Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-20T16:04:25.349332Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-20T16:04:25.349407Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-20T16:04:25.349888Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c5133f40b27eeb3","local-member-id":"17dd22a2661aae79","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T16:04:25.350285Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T16:04:25.350335Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T16:04:25.353088Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.41:2379"}
{"level":"info","ts":"2026-02-20T16:04:25.35338Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-20T16:04:25.35612Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-02-20T16:04:51.37181Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291818175,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:04:51.439007Z","caller":"traceutil/trace.go:171","msg":"trace[1682816028] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"568.280932ms","start":"2026-02-20T16:04:50.870702Z","end":"2026-02-20T16:04:51.438983Z","steps":["trace[1682816028] 'read index received'  (duration: 568.18791ms)","trace[1682816028] 'applied index is now lower than readState.Index'  (duration: 91.862µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:04:51.439144Z","caller":"traceutil/trace.go:171","msg":"trace[273424925] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"733.845355ms","start":"2026-02-20T16:04:50.705288Z","end":"2026-02-20T16:04:51.439133Z","steps":["trace[273424925] 'process raft request'  (duration: 733.522396ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:51.439289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.011416ms","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-20T16:04:51.439377Z","caller":"traceutil/trace.go:171","msg":"trace[947389217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"365.160999ms","start":"2026-02-20T16:04:51.074196Z","end":"2026-02-20T16:04:51.439357Z","steps":["trace[947389217] 'agreement among raft nodes before linearized reading'  (duration: 365.017096ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:51.439423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:51.074177Z","time spent":"365.236931ms","remote":"127.0.0.1:38568","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-20T16:04:51.439568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.862527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:04:51.439599Z","caller":"traceutil/trace.go:171","msg":"trace[760885663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:428; }","duration":"568.927749ms","start":"2026-02-20T16:04:50.870663Z","end":"2026-02-20T16:04:51.439591Z","steps":["trace[760885663] 'agreement among raft nodes before linearized reading'  (duration: 568.881418ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:51.439624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:50.870644Z","time spent":"568.974321ms","remote":"127.0.0.1:38322","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-20T16:04:51.439688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:50.705264Z","time spent":"733.913446ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:373 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-20T16:04:51.439848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.428316ms","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-20T16:04:51.439929Z","caller":"traceutil/trace.go:171","msg":"trace[1782340235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"357.56261ms","start":"2026-02-20T16:04:51.082348Z","end":"2026-02-20T16:04:51.43991Z","steps":["trace[1782340235] 'agreement among raft nodes before linearized reading'  (duration: 357.397586ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:51.439978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:51.082338Z","time spent":"357.630461ms","remote":"127.0.0.1:38568","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-20T16:04:51.439983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.131175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-20T16:04:51.440021Z","caller":"traceutil/trace.go:171","msg":"trace[304694387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"213.205326ms","start":"2026-02-20T16:04:51.226806Z","end":"2026-02-20T16:04:51.440012Z","steps":["trace[304694387] 'agreement among raft nodes before linearized reading'  (duration: 213.126885ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:04:52.026525Z","caller":"traceutil/trace.go:171","msg":"trace[1837233973] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"579.325719ms","start":"2026-02-20T16:04:51.44718Z","end":"2026-02-20T16:04:52.026506Z","steps":["trace[1837233973] 'process raft request'  (duration: 568.614532ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:52.026627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:51.447164Z","time spent":"579.411931ms","remote":"127.0.0.1:38568","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:424 > 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-20T16:04:52.027223Z","caller":"traceutil/trace.go:171","msg":"trace[619712686] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:444; }","duration":"177.60732ms","start":"2026-02-20T16:04:51.84959Z","end":"2026-02-20T16:04:52.027197Z","steps":["trace[619712686] 'read index received'  (duration: 166.214556ms)","trace[619712686] 'applied index is now lower than readState.Index'  (duration: 11.391404ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:04:52.027395Z","caller":"traceutil/trace.go:171","msg":"trace[2142663369] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"580.041147ms","start":"2026-02-20T16:04:51.447337Z","end":"2026-02-20T16:04:52.027379Z","steps":["trace[2142663369] 'process raft request'  (duration: 579.711828ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:52.027524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:51.44733Z","time spent":"580.1634ms","remote":"127.0.0.1:38568","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:425 > 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-20T16:04:52.027701Z","caller":"traceutil/trace.go:171","msg":"trace[23407853] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"543.185909ms","start":"2026-02-20T16:04:51.484495Z","end":"2026-02-20T16:04:52.027681Z","steps":["trace[23407853] 'process raft request'  (duration: 542.652065ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:52.027767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.836379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:04:52.028002Z","caller":"traceutil/trace.go:171","msg":"trace[1447813587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"154.093305ms","start":"2026-02-20T16:04:51.87389Z","end":"2026-02-20T16:04:52.027984Z","steps":["trace[1447813587] 'agreement among raft nodes before linearized reading'  (duration: 153.848779ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:52.027821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.236426ms","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-20T16:04:52.028126Z","caller":"traceutil/trace.go:171","msg":"trace[504660758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:431; }","duration":"178.555834ms","start":"2026-02-20T16:04:51.84954Z","end":"2026-02-20T16:04:52.028096Z","steps":["trace[504660758] 'agreement among raft nodes before linearized reading'  (duration: 178.244206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:52.027963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:51.484481Z","time spent":"543.388084ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:426 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-20T16:04:56.333102Z","caller":"traceutil/trace.go:171","msg":"trace[1121072606] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"285.771862ms","start":"2026-02-20T16:04:56.047302Z","end":"2026-02-20T16:04:56.333073Z","steps":["trace[1121072606] 'process raft request'  (duration: 285.604717ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:04:57.646024Z","caller":"traceutil/trace.go:171","msg":"trace[407115999] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:487; }","duration":"1.590572376s","start":"2026-02-20T16:04:56.055424Z","end":"2026-02-20T16:04:57.645997Z","steps":["trace[407115999] 'read index received'  (duration: 277.519616ms)","trace[407115999] 'applied index is now lower than readState.Index'  (duration: 1.31305158s)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:04:57.6463Z","caller":"traceutil/trace.go:171","msg":"trace[950880328] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"1.597458857s","start":"2026-02-20T16:04:56.048825Z","end":"2026-02-20T16:04:57.646284Z","steps":["trace[950880328] 'process raft request'  (duration: 1.596991966s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:57.646479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.039677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:04:57.646509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.591061588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-02-20T16:04:57.646513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.632373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4020"}
{"level":"info","ts":"2026-02-20T16:04:57.646489Z","caller":"traceutil/trace.go:171","msg":"trace[581145194] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"1.597417536s","start":"2026-02-20T16:04:56.049027Z","end":"2026-02-20T16:04:57.646444Z","steps":["trace[581145194] 'process raft request'  (duration: 1.596903693s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:04:57.646572Z","caller":"traceutil/trace.go:171","msg":"trace[605970957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"772.175811ms","start":"2026-02-20T16:04:56.874372Z","end":"2026-02-20T16:04:57.646548Z","steps":["trace[605970957] 'agreement among raft nodes before linearized reading'  (duration: 772.028997ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:04:57.646576Z","caller":"traceutil/trace.go:171","msg":"trace[1699563656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:473; }","duration":"1.59115209s","start":"2026-02-20T16:04:56.055404Z","end":"2026-02-20T16:04:57.646556Z","steps":["trace[1699563656] 'agreement among raft nodes before linearized reading'  (duration: 1.590993126s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:04:57.646579Z","caller":"traceutil/trace.go:171","msg":"trace[147393434] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:473; }","duration":"510.726366ms","start":"2026-02-20T16:04:57.135837Z","end":"2026-02-20T16:04:57.646563Z","steps":["trace[147393434] 'agreement among raft nodes before linearized reading'  (duration: 510.606493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:04:57.646569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:56.048807Z","time spent":"1.597521359s","remote":"127.0.0.1:38568","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:433 > 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-20T16:04:57.646616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:56.874343Z","time spent":"772.264343ms","remote":"127.0.0.1:38322","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-20T16:04:57.646621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:57.135819Z","time spent":"510.793818ms","remote":"127.0.0.1:38478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4042,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-20T16:04:57.64662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:56.055397Z","time spent":"1.591213792s","remote":"127.0.0.1:38568","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-20T16:04:57.646669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:04:56.049012Z","time spent":"1.597576221s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:434 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-20T16:05:03.876303Z","caller":"traceutil/trace.go:171","msg":"trace[497865104] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:508; }","duration":"209.203381ms","start":"2026-02-20T16:05:03.667079Z","end":"2026-02-20T16:05:03.876283Z","steps":["trace[497865104] 'read index received'  (duration: 209.041407ms)","trace[497865104] 'applied index is now lower than readState.Index'  (duration: 160.934µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:05:03.876413Z","caller":"traceutil/trace.go:171","msg":"trace[1645711847] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"472.325747ms","start":"2026-02-20T16:05:03.404059Z","end":"2026-02-20T16:05:03.876385Z","steps":["trace[1645711847] 'process raft request'  (duration: 472.081001ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:03.876501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.402035ms","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-20T16:05:03.876569Z","caller":"traceutil/trace.go:171","msg":"trace[304521613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:491; }","duration":"209.524739ms","start":"2026-02-20T16:05:03.667028Z","end":"2026-02-20T16:05:03.876553Z","steps":["trace[304521613] 'agreement among raft nodes before linearized reading'  (duration: 209.367746ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:03.876569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:03.404033Z","time spent":"472.465111ms","remote":"127.0.0.1:38486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-wjkmm\" mod_revision:465 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-wjkmm\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-wjkmm\" > >"}
{"level":"warn","ts":"2026-02-20T16:05:05.072352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.87241ms","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-20T16:05:05.072532Z","caller":"traceutil/trace.go:171","msg":"trace[437428715] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:491; }","duration":"499.063265ms","start":"2026-02-20T16:05:04.573447Z","end":"2026-02-20T16:05:05.072511Z","steps":["trace[437428715] 'range keys from in-memory index tree'  (duration: 498.85595ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:05.695334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398574093s","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291818311 > lease_revoke:<id:2e799c7bcb93beb0>","response":"size:27"}
{"level":"info","ts":"2026-02-20T16:05:05.695588Z","caller":"traceutil/trace.go:171","msg":"trace[1497542832] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"1.819191411s","start":"2026-02-20T16:05:03.876365Z","end":"2026-02-20T16:05:05.695556Z","steps":["trace[1497542832] 'read index received'  (duration: 420.269018ms)","trace[1497542832] 'applied index is now lower than readState.Index'  (duration: 1.398918593s)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:05:05.69563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.82236697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:05.695686Z","caller":"traceutil/trace.go:171","msg":"trace[1350166137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:491; }","duration":"1.822447462s","start":"2026-02-20T16:05:03.873214Z","end":"2026-02-20T16:05:05.695661Z","steps":["trace[1350166137] 'agreement among raft nodes before linearized reading'  (duration: 1.82235988s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:05.695731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:03.873196Z","time spent":"1.822525294s","remote":"127.0.0.1:38330","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-20T16:05:05.695767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.024120355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-20T16:05:05.695829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.024653189s","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-20T16:05:05.695913Z","caller":"traceutil/trace.go:171","msg":"trace[1788224189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:491; }","duration":"2.024773001s","start":"2026-02-20T16:05:03.67112Z","end":"2026-02-20T16:05:05.695893Z","steps":["trace[1788224189] 'agreement among raft nodes before linearized reading'  (duration: 2.024586487s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:05.695896Z","caller":"traceutil/trace.go:171","msg":"trace[761730273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:491; }","duration":"2.024242549s","start":"2026-02-20T16:05:03.671596Z","end":"2026-02-20T16:05:05.695839Z","steps":["trace[761730273] 'agreement among raft nodes before linearized reading'  (duration: 2.024051904s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:05.695968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:03.671109Z","time spent":"2.024849574s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:05:05.696045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:03.671589Z","time spent":"2.024406833s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:05:05.696592Z","caller":"traceutil/trace.go:171","msg":"trace[40839814] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"1.815498308s","start":"2026-02-20T16:05:03.88108Z","end":"2026-02-20T16:05:05.696578Z","steps":["trace[40839814] 'process raft request'  (duration: 1.814410331s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:05.696614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338162316s","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-20T16:05:05.696658Z","caller":"traceutil/trace.go:171","msg":"trace[1039699033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:492; }","duration":"1.338243299s","start":"2026-02-20T16:05:04.358402Z","end":"2026-02-20T16:05:05.696646Z","steps":["trace[1039699033] 'agreement among raft nodes before linearized reading'  (duration: 1.338145496s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:05.696712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:03.88106Z","time spent":"1.81557024s","remote":"127.0.0.1:38568","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:483 > 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-20T16:05:05.696725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:04.358381Z","time spent":"1.33833505s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-20T16:05:05.941856Z","caller":"traceutil/trace.go:171","msg":"trace[119504340] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:512; }","duration":"239.009315ms","start":"2026-02-20T16:05:05.702826Z","end":"2026-02-20T16:05:05.941835Z","steps":["trace[119504340] 'read index received'  (duration: 32.482921ms)","trace[119504340] 'applied index is now lower than readState.Index'  (duration: 206.525374ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:05:05.941987Z","caller":"traceutil/trace.go:171","msg":"trace[221873216] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"240.392299ms","start":"2026-02-20T16:05:05.701569Z","end":"2026-02-20T16:05:05.941961Z","steps":["trace[221873216] 'process raft request'  (duration: 240.216825ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:05.94199Z","caller":"traceutil/trace.go:171","msg":"trace[248605380] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"241.245651ms","start":"2026-02-20T16:05:05.700681Z","end":"2026-02-20T16:05:05.941926Z","steps":["trace[248605380] 'process raft request'  (duration: 240.939523ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:05.942256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.423515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:05.942307Z","caller":"traceutil/trace.go:171","msg":"trace[1941858313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:495; }","duration":"239.480826ms","start":"2026-02-20T16:05:05.702814Z","end":"2026-02-20T16:05:05.942294Z","steps":["trace[1941858313] 'agreement among raft nodes before linearized reading'  (duration: 239.099007ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:08.239898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291818322,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:05:08.740549Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291818322,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:05:09.047454Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.342921024s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-20T16:05:09.047848Z","caller":"traceutil/trace.go:171","msg":"trace[1525878156] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.343389026s","start":"2026-02-20T16:05:07.704431Z","end":"2026-02-20T16:05:09.04782Z","steps":["trace[1525878156] 'process raft request'  (duration: 1.343235062s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.048004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:07.704414Z","time spent":"1.343494629s","remote":"127.0.0.1:38568","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:492 > 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-20T16:05:09.198461Z","caller":"traceutil/trace.go:171","msg":"trace[1044880467] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:515; }","duration":"1.459511105s","start":"2026-02-20T16:05:07.738922Z","end":"2026-02-20T16:05:09.198433Z","steps":["trace[1044880467] 'read index received'  (duration: 1.309098531s)","trace[1044880467] 'applied index is now lower than readState.Index'  (duration: 150.411164ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:05:09.198586Z","caller":"traceutil/trace.go:171","msg":"trace[1012967604] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"982.859199ms","start":"2026-02-20T16:05:08.215706Z","end":"2026-02-20T16:05:09.198565Z","steps":["trace[1012967604] 'process raft request'  (duration: 977.507086ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.198652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459715121s","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-20T16:05:09.198686Z","caller":"traceutil/trace.go:171","msg":"trace[241625237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:497; }","duration":"1.459811443s","start":"2026-02-20T16:05:07.738865Z","end":"2026-02-20T16:05:09.198676Z","steps":["trace[241625237] 'agreement among raft nodes before linearized reading'  (duration: 1.45970993s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.198718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.149575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.41\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-02-20T16:05:09.19874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:07.738845Z","time spent":"1.459885204s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:05:09.19876Z","caller":"traceutil/trace.go:171","msg":"trace[644524533] range","detail":"{range_begin:/registry/masterleases/199.204.45.41; range_end:; response_count:1; response_revision:497; }","duration":"662.229846ms","start":"2026-02-20T16:05:08.536512Z","end":"2026-02-20T16:05:09.198742Z","steps":["trace[644524533] 'agreement among raft nodes before linearized reading'  (duration: 662.149455ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.198749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324983697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:05:09.198826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:08.536486Z","time spent":"662.329449ms","remote":"127.0.0.1:38346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.41\" "}
{"level":"warn","ts":"2026-02-20T16:05:09.198827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252908648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-20T16:05:09.198884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.618375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:09.198915Z","caller":"traceutil/trace.go:171","msg":"trace[1010048328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:497; }","duration":"1.253076893s","start":"2026-02-20T16:05:07.945817Z","end":"2026-02-20T16:05:09.198894Z","steps":["trace[1010048328] 'agreement among raft nodes before linearized reading'  (duration: 1.252872978s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.198857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253243977s","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-20T16:05:09.198959Z","caller":"traceutil/trace.go:171","msg":"trace[1702622184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"228.739448ms","start":"2026-02-20T16:05:08.970202Z","end":"2026-02-20T16:05:09.198941Z","steps":["trace[1702622184] 'agreement among raft nodes before linearized reading'  (duration: 228.617135ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.198965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:07.945791Z","time spent":"1.253164135s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-20T16:05:09.19885Z","caller":"traceutil/trace.go:171","msg":"trace[1560084418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"1.325158852s","start":"2026-02-20T16:05:07.873672Z","end":"2026-02-20T16:05:09.198831Z","steps":["trace[1560084418] 'agreement among raft nodes before linearized reading'  (duration: 1.324965287s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:09.199006Z","caller":"traceutil/trace.go:171","msg":"trace[586872244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:497; }","duration":"1.253425742s","start":"2026-02-20T16:05:07.945562Z","end":"2026-02-20T16:05:09.198988Z","steps":["trace[586872244] 'agreement among raft nodes before linearized reading'  (duration: 1.253178225s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:09.199074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:07.873651Z","time spent":"1.325405108s","remote":"127.0.0.1:38322","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-20T16:05:09.19918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:07.945546Z","time spent":"1.253613666s","remote":"127.0.0.1:38568","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-20T16:05:09.199236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:08.215683Z","time spent":"983.489334ms","remote":"127.0.0.1:38568","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:476 > 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-20T16:05:11.676808Z","caller":"traceutil/trace.go:171","msg":"trace[239324338] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"112.62483ms","start":"2026-02-20T16:05:11.564157Z","end":"2026-02-20T16:05:11.676781Z","steps":["trace[239324338] 'process raft request'  (duration: 112.478707ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:25.67967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.546203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-02-20T16:05:25.679694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.020459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-20T16:05:25.679647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.386119ms","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-20T16:05:25.679791Z","caller":"traceutil/trace.go:171","msg":"trace[91626380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:672; }","duration":"383.183382ms","start":"2026-02-20T16:05:25.296585Z","end":"2026-02-20T16:05:25.679768Z","steps":["trace[91626380] 'range keys from in-memory index tree'  (duration: 382.765772ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:25.679803Z","caller":"traceutil/trace.go:171","msg":"trace[711353744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:672; }","duration":"361.612245ms","start":"2026-02-20T16:05:25.31817Z","end":"2026-02-20T16:05:25.679782Z","steps":["trace[711353744] 'range keys from in-memory index tree'  (duration: 361.188124ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:25.679811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.154533ms","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-20T16:05:25.679783Z","caller":"traceutil/trace.go:171","msg":"trace[1429059134] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:672; }","duration":"254.698627ms","start":"2026-02-20T16:05:25.425058Z","end":"2026-02-20T16:05:25.679757Z","steps":["trace[1429059134] 'range keys from in-memory index tree'  (duration: 254.369739ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:25.679867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.318148Z","time spent":"361.706497ms","remote":"127.0.0.1:38568","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-20T16:05:25.680106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.056946ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291818657 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/coredns-5dd5756b68-j4tlr.18960005286e8457\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-5dd5756b68-j4tlr.18960005286e8457\" value_size:729 lease:3348879853437041924 >> failure:<>>","response":"size:16"}
{"level":"warn","ts":"2026-02-20T16:05:25.680198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.296558Z","time spent":"383.569531ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-20T16:05:25.680081Z","caller":"traceutil/trace.go:171","msg":"trace[1468167609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:672; }","duration":"381.301506ms","start":"2026-02-20T16:05:25.298576Z","end":"2026-02-20T16:05:25.679877Z","steps":["trace[1468167609] 'range keys from in-memory index tree'  (duration: 380.966078ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:25.680431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.298554Z","time spent":"381.85672ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:05:25.680627Z","caller":"traceutil/trace.go:171","msg":"trace[1289016737] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"107.748159ms","start":"2026-02-20T16:05:25.572484Z","end":"2026-02-20T16:05:25.680232Z","steps":["trace[1289016737] 'compare'  (duration: 99.879652ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:26.373588Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291818656,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:05:26.594779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.370775ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291818659 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:668 > 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-20T16:05:26.594977Z","caller":"traceutil/trace.go:171","msg":"trace[1777623648] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"910.275938ms","start":"2026-02-20T16:05:25.684682Z","end":"2026-02-20T16:05:26.594958Z","steps":["trace[1777623648] 'process raft request'  (duration: 793.657797ms)","trace[1777623648] 'compare'  (duration: 91.976685ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:05:26.595093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.684661Z","time spent":"910.362169ms","remote":"127.0.0.1:38568","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:668 > 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-20T16:05:26.595261Z","caller":"traceutil/trace.go:171","msg":"trace[2076455207] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"910.315879ms","start":"2026-02-20T16:05:25.684936Z","end":"2026-02-20T16:05:26.595252Z","steps":["trace[2076455207] 'process raft request'  (duration: 909.922419ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:26.59558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.684906Z","time spent":"910.647866ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:669 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-20T16:05:26.59528Z","caller":"traceutil/trace.go:171","msg":"trace[317725169] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"909.930569ms","start":"2026-02-20T16:05:25.685329Z","end":"2026-02-20T16:05:26.595259Z","steps":["trace[317725169] 'process raft request'  (duration: 909.819956ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:26.595893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.685302Z","time spent":"910.513894ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:671 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:05:26.595199Z","caller":"traceutil/trace.go:171","msg":"trace[1878754336] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:698; }","duration":"721.977358ms","start":"2026-02-20T16:05:25.873205Z","end":"2026-02-20T16:05:26.595182Z","steps":["trace[1878754336] 'read index received'  (duration: 605.07475ms)","trace[1878754336] 'applied index is now lower than readState.Index'  (duration: 116.901898ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:05:26.595345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.139662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:26.596257Z","caller":"traceutil/trace.go:171","msg":"trace[2126152470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"723.067895ms","start":"2026-02-20T16:05:25.873167Z","end":"2026-02-20T16:05:26.596235Z","steps":["trace[2126152470] 'agreement among raft nodes before linearized reading'  (duration: 722.154103ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:26.596336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.689236ms","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-20T16:05:26.596374Z","caller":"traceutil/trace.go:171","msg":"trace[113395032] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:677; }","duration":"234.746668ms","start":"2026-02-20T16:05:26.36162Z","end":"2026-02-20T16:05:26.596366Z","steps":["trace[113395032] 'agreement among raft nodes before linearized reading'  (duration: 234.670365ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:26.596356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:25.873144Z","time spent":"723.20288ms","remote":"127.0.0.1:38322","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-20T16:05:28.641061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082391453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-20T16:05:28.641145Z","caller":"traceutil/trace.go:171","msg":"trace[1276411352] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:677; }","duration":"1.082521056s","start":"2026-02-20T16:05:27.558607Z","end":"2026-02-20T16:05:28.641128Z","steps":["trace[1276411352] 'count revisions from in-memory index tree'  (duration: 1.082237128s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:28.641188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:27.558516Z","time spent":"1.082660649s","remote":"127.0.0.1:38468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":2,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T16:05:28.641319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.964083ms","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-20T16:05:28.641387Z","caller":"traceutil/trace.go:171","msg":"trace[1402672010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"939.080327ms","start":"2026-02-20T16:05:27.702291Z","end":"2026-02-20T16:05:28.641371Z","steps":["trace[1402672010] 'range keys from in-memory index tree'  (duration: 938.80632ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:28.641426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:27.702267Z","time spent":"939.149009ms","remote":"127.0.0.1:38568","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-20T16:05:28.641425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.684324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.41\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-20T16:05:28.641487Z","caller":"traceutil/trace.go:171","msg":"trace[136004752] range","detail":"{range_begin:/registry/masterleases/199.204.45.41; range_end:; response_count:1; response_revision:677; }","duration":"104.739305ms","start":"2026-02-20T16:05:28.536719Z","end":"2026-02-20T16:05:28.641459Z","steps":["trace[136004752] 'range keys from in-memory index tree'  (duration: 104.56068ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:28.641706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.616333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:28.641743Z","caller":"traceutil/trace.go:171","msg":"trace[528479739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"768.702965ms","start":"2026-02-20T16:05:27.87303Z","end":"2026-02-20T16:05:28.641733Z","steps":["trace[528479739] 'range keys from in-memory index tree'  (duration: 768.54841ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:28.641767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:27.873009Z","time spent":"768.750735ms","remote":"127.0.0.1:38322","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-20T16:05:28.641989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.517559883s","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-20T16:05:28.64203Z","caller":"traceutil/trace.go:171","msg":"trace[1035743664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"1.517600914s","start":"2026-02-20T16:05:27.124419Z","end":"2026-02-20T16:05:28.642019Z","steps":["trace[1035743664] 'range keys from in-memory index tree'  (duration: 1.51743202s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:28.642059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:27.124352Z","time spent":"1.517698387s","remote":"127.0.0.1:38568","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-20T16:05:28.642108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335777887s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-20T16:05:28.642202Z","caller":"traceutil/trace.go:171","msg":"trace[1850253106] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:677; }","duration":"1.33590895s","start":"2026-02-20T16:05:27.306281Z","end":"2026-02-20T16:05:28.64219Z","steps":["trace[1850253106] 'count revisions from in-memory index tree'  (duration: 1.335715215s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:28.64223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:27.306265Z","time spent":"1.335956521s","remote":"127.0.0.1:38648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":51,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"info","ts":"2026-02-20T16:05:28.903672Z","caller":"traceutil/trace.go:171","msg":"trace[1443929291] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"259.185757ms","start":"2026-02-20T16:05:28.644468Z","end":"2026-02-20T16:05:28.903654Z","steps":["trace[1443929291] 'read index received'  (duration: 259.019763ms)","trace[1443929291] 'applied index is now lower than readState.Index'  (duration: 164.584µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:05:28.903802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.29667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:28.903828Z","caller":"traceutil/trace.go:171","msg":"trace[1947541105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"259.370821ms","start":"2026-02-20T16:05:28.644449Z","end":"2026-02-20T16:05:28.90382Z","steps":["trace[1947541105] 'agreement among raft nodes before linearized reading'  (duration: 259.288949ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:29.031239Z","caller":"traceutil/trace.go:171","msg":"trace[983424129] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"384.64339ms","start":"2026-02-20T16:05:28.646569Z","end":"2026-02-20T16:05:29.031213Z","steps":["trace[983424129] 'process raft request'  (duration: 384.445525ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:29.031248Z","caller":"traceutil/trace.go:171","msg":"trace[813847136] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"384.486976ms","start":"2026-02-20T16:05:28.64674Z","end":"2026-02-20T16:05:29.031227Z","steps":["trace[813847136] 'process raft request'  (duration: 384.422704ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:29.031379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:28.646553Z","time spent":"384.748083ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:676 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-20T16:05:29.031408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:28.646733Z","time spent":"384.600559ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:677 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:05:29.031502Z","caller":"traceutil/trace.go:171","msg":"trace[536629402] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"383.793818ms","start":"2026-02-20T16:05:28.647698Z","end":"2026-02-20T16:05:29.031491Z","steps":["trace[536629402] 'process raft request'  (duration: 383.693286ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:29.031524Z","caller":"traceutil/trace.go:171","msg":"trace[2029799684] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"384.577908ms","start":"2026-02-20T16:05:28.646937Z","end":"2026-02-20T16:05:29.031514Z","steps":["trace[2029799684] 'process raft request'  (duration: 384.26123ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:29.031558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:28.647691Z","time spent":"383.839779ms","remote":"127.0.0.1:38568","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:674 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:05:29.031572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:28.646931Z","time spent":"384.614119ms","remote":"127.0.0.1:38568","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:675 > 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-20T16:05:29.031556Z","caller":"traceutil/trace.go:171","msg":"trace[1434908483] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"383.707385ms","start":"2026-02-20T16:05:28.647828Z","end":"2026-02-20T16:05:29.031535Z","steps":["trace[1434908483] 'process raft request'  (duration: 383.638934ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:29.031662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:28.647811Z","time spent":"383.791428ms","remote":"127.0.0.1:38568","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:672 > 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-20T16:05:29.112339Z","caller":"traceutil/trace.go:171","msg":"trace[828577025] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:702; }","duration":"202.211717ms","start":"2026-02-20T16:05:28.9101Z","end":"2026-02-20T16:05:29.112312Z","steps":["trace[828577025] 'read index received'  (duration: 120.96129ms)","trace[828577025] 'applied index is now lower than readState.Index'  (duration: 81.249147ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:05:29.112408Z","caller":"traceutil/trace.go:171","msg":"trace[1352419327] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"207.385796ms","start":"2026-02-20T16:05:28.904994Z","end":"2026-02-20T16:05:29.11238Z","steps":["trace[1352419327] 'process raft request'  (duration: 207.185891ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:29.112494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.365141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:05:29.112535Z","caller":"traceutil/trace.go:171","msg":"trace[966235460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"202.453514ms","start":"2026-02-20T16:05:28.910071Z","end":"2026-02-20T16:05:29.112525Z","steps":["trace[966235460] 'agreement among raft nodes before linearized reading'  (duration: 202.337801ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:29.263659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.366248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-20T16:05:29.263755Z","caller":"traceutil/trace.go:171","msg":"trace[509518232] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:683; }","duration":"147.507161ms","start":"2026-02-20T16:05:29.116229Z","end":"2026-02-20T16:05:29.263736Z","steps":["trace[509518232] 'range keys from in-memory index tree'  (duration: 147.255256ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:29.786309Z","caller":"traceutil/trace.go:171","msg":"trace[553759543] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"119.831811ms","start":"2026-02-20T16:05:29.666454Z","end":"2026-02-20T16:05:29.786286Z","steps":["trace[553759543] 'process raft request'  (duration: 119.651147ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:57.670334Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291818916,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:05:57.683495Z","caller":"traceutil/trace.go:171","msg":"trace[1538035331] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"513.601588ms","start":"2026-02-20T16:05:57.169867Z","end":"2026-02-20T16:05:57.683469Z","steps":["trace[1538035331] 'read index received'  (duration: 513.420083ms)","trace[1538035331] 'applied index is now lower than readState.Index'  (duration: 180.605µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:05:57.683541Z","caller":"traceutil/trace.go:171","msg":"trace[749290426] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"524.46146ms","start":"2026-02-20T16:05:57.159057Z","end":"2026-02-20T16:05:57.683519Z","steps":["trace[749290426] 'process raft request'  (duration: 524.284486ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:57.683683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.159043Z","time spent":"524.553202ms","remote":"127.0.0.1:38568","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:759 > 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-20T16:05:57.683736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.62265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-02-20T16:05:57.683779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.034702ms","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-20T16:05:57.683807Z","caller":"traceutil/trace.go:171","msg":"trace[1760912951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:764; }","duration":"481.702802ms","start":"2026-02-20T16:05:57.202082Z","end":"2026-02-20T16:05:57.683785Z","steps":["trace[1760912951] 'agreement among raft nodes before linearized reading'  (duration: 481.549278ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:57.683841Z","caller":"traceutil/trace.go:171","msg":"trace[874569895] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:764; }","duration":"444.111143ms","start":"2026-02-20T16:05:57.239709Z","end":"2026-02-20T16:05:57.68382Z","steps":["trace[874569895] 'agreement among raft nodes before linearized reading'  (duration: 443.944219ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:57.683859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.202075Z","time spent":"481.774573ms","remote":"127.0.0.1:38568","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-20T16:05:57.683889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.239696Z","time spent":"444.182076ms","remote":"127.0.0.1:38568","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-20T16:05:57.683901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.849745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-20T16:05:57.683923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.863177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-20T16:05:57.684028Z","caller":"traceutil/trace.go:171","msg":"trace[1475987034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:764; }","duration":"462.026211ms","start":"2026-02-20T16:05:57.221981Z","end":"2026-02-20T16:05:57.684007Z","steps":["trace[1475987034] 'agreement among raft nodes before linearized reading'  (duration: 461.715853ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:57.684082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.221955Z","time spent":"462.117093ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-20T16:05:57.683952Z","caller":"traceutil/trace.go:171","msg":"trace[1436969939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:764; }","duration":"514.0914ms","start":"2026-02-20T16:05:57.169845Z","end":"2026-02-20T16:05:57.683937Z","steps":["trace[1436969939] 'agreement among raft nodes before linearized reading'  (duration: 513.752202ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:57.684277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.169836Z","time spent":"514.404318ms","remote":"127.0.0.1:38568","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":"info","ts":"2026-02-20T16:05:58.331556Z","caller":"traceutil/trace.go:171","msg":"trace[456316525] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"642.619787ms","start":"2026-02-20T16:05:57.688909Z","end":"2026-02-20T16:05:58.331529Z","steps":["trace[456316525] 'process raft request'  (duration: 609.993782ms)","trace[456316525] 'compare'  (duration: 32.081922ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:05:58.331696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.688902Z","time spent":"642.723069ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:762 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-20T16:05:58.331874Z","caller":"traceutil/trace.go:171","msg":"trace[1958730218] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"643.013698ms","start":"2026-02-20T16:05:57.688829Z","end":"2026-02-20T16:05:58.331842Z","steps":["trace[1958730218] 'process raft request'  (duration: 642.645329ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:58.331962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.688804Z","time spent":"643.115081ms","remote":"127.0.0.1:38568","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:761 > 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-20T16:05:58.332152Z","caller":"traceutil/trace.go:171","msg":"trace[1600647014] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"643.12458ms","start":"2026-02-20T16:05:57.689018Z","end":"2026-02-20T16:05:58.332142Z","steps":["trace[1600647014] 'process raft request'  (duration: 642.650148ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:05:58.332198Z","caller":"traceutil/trace.go:171","msg":"trace[1702770371] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"643.13957ms","start":"2026-02-20T16:05:57.689046Z","end":"2026-02-20T16:05:58.332186Z","steps":["trace[1702770371] 'process raft request'  (duration: 643.057818ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:05:58.332212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.688989Z","time spent":"643.193701ms","remote":"127.0.0.1:38568","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:760 > 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-20T16:05:58.332269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:57.68902Z","time spent":"643.212192ms","remote":"127.0.0.1:38568","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:763 > 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-20T16:05:58.888692Z","caller":"traceutil/trace.go:171","msg":"trace[302602046] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"239.314237ms","start":"2026-02-20T16:05:58.649339Z","end":"2026-02-20T16:05:58.888654Z","steps":["trace[302602046] 'process raft request'  (duration: 239.129582ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:00.724392Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291818934,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:06:01.055198Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.355684794s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-20T16:06:01.055603Z","caller":"traceutil/trace.go:171","msg":"trace[1296716859] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"1.356196307s","start":"2026-02-20T16:05:59.699378Z","end":"2026-02-20T16:06:01.055574Z","steps":["trace[1296716859] 'process raft request'  (duration: 1.356005552s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:01.055785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:05:59.699358Z","time spent":"1.3563295s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:764 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:06:01.076353Z","caller":"traceutil/trace.go:171","msg":"trace[1944396522] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:801; }","duration":"852.407464ms","start":"2026-02-20T16:06:00.223933Z","end":"2026-02-20T16:06:01.07634Z","steps":["trace[1944396522] 'read index received'  (duration: 831.425266ms)","trace[1944396522] 'applied index is now lower than readState.Index'  (duration: 20.981308ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:01.076437Z","caller":"traceutil/trace.go:171","msg":"trace[945122425] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"430.257924ms","start":"2026-02-20T16:06:00.646151Z","end":"2026-02-20T16:06:01.076409Z","steps":["trace[945122425] 'process raft request'  (duration: 430.12996ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:01.076606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:00.646119Z","time spent":"430.393307ms","remote":"127.0.0.1:38568","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:747 > 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-20T16:06:01.076633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.530309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-02-20T16:06:01.076698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.109458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-02-20T16:06:01.076727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.654438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:01.076663Z","caller":"traceutil/trace.go:171","msg":"trace[1610222515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:771; }","duration":"740.625872ms","start":"2026-02-20T16:06:00.336028Z","end":"2026-02-20T16:06:01.076654Z","steps":["trace[1610222515] 'agreement among raft nodes before linearized reading'  (duration: 740.447757ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:01.076784Z","caller":"traceutil/trace.go:171","msg":"trace[1804062672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:771; }","duration":"740.262421ms","start":"2026-02-20T16:06:00.336499Z","end":"2026-02-20T16:06:01.076762Z","steps":["trace[1804062672] 'agreement among raft nodes before linearized reading'  (duration: 740.037896ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:01.076806Z","caller":"traceutil/trace.go:171","msg":"trace[164496328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:771; }","duration":"202.803862ms","start":"2026-02-20T16:06:00.873984Z","end":"2026-02-20T16:06:01.076788Z","steps":["trace[164496328] 'agreement among raft nodes before linearized reading'  (duration: 202.661718ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:01.076744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.22436ms","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-20T16:06:01.076844Z","caller":"traceutil/trace.go:171","msg":"trace[1991596056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:771; }","duration":"740.357914ms","start":"2026-02-20T16:06:00.336478Z","end":"2026-02-20T16:06:01.076836Z","steps":["trace[1991596056] 'agreement among raft nodes before linearized reading'  (duration: 740.082747ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:01.076836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:00.336477Z","time spent":"740.348944ms","remote":"127.0.0.1:38568","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-20T16:06:01.076868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:00.33647Z","time spent":"740.392425ms","remote":"127.0.0.1:38568","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-20T16:06:01.076816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:00.335996Z","time spent":"740.811026ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:06:01.077024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.05338ms","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-20T16:06:01.077068Z","caller":"traceutil/trace.go:171","msg":"trace[1969735077] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:771; }","duration":"853.178773ms","start":"2026-02-20T16:06:00.223883Z","end":"2026-02-20T16:06:01.077062Z","steps":["trace[1969735077] 'agreement among raft nodes before linearized reading'  (duration: 852.554497ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:01.077025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.735103ms","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-20T16:06:01.077395Z","caller":"traceutil/trace.go:171","msg":"trace[244188025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"741.193825ms","start":"2026-02-20T16:06:00.336185Z","end":"2026-02-20T16:06:01.077378Z","steps":["trace[244188025] 'agreement among raft nodes before linearized reading'  (duration: 740.519238ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:01.077117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:00.223856Z","time spent":"853.228114ms","remote":"127.0.0.1:38440","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-20T16:06:01.077549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:00.336178Z","time spent":"741.309797ms","remote":"127.0.0.1:38568","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":"info","ts":"2026-02-20T16:06:01.319367Z","caller":"traceutil/trace.go:171","msg":"trace[1577087327] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"237.383221ms","start":"2026-02-20T16:06:01.081961Z","end":"2026-02-20T16:06:01.319344Z","steps":["trace[1577087327] 'process raft request'  (duration: 237.147275ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:01.319374Z","caller":"traceutil/trace.go:171","msg":"trace[973557005] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"235.847583ms","start":"2026-02-20T16:06:01.083481Z","end":"2026-02-20T16:06:01.319329Z","steps":["trace[973557005] 'process raft request'  (duration: 235.808402ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:01.319394Z","caller":"traceutil/trace.go:171","msg":"trace[373405108] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"236.243473ms","start":"2026-02-20T16:06:01.083125Z","end":"2026-02-20T16:06:01.319369Z","steps":["trace[373405108] 'process raft request'  (duration: 236.12608ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:02.711221Z","caller":"traceutil/trace.go:171","msg":"trace[133383594] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"120.809299ms","start":"2026-02-20T16:06:02.590389Z","end":"2026-02-20T16:06:02.711199Z","steps":["trace[133383594] 'process raft request'  (duration: 120.659216ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:03.251927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.925487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:06:03.252015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.151349ms","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-20T16:06:03.252026Z","caller":"traceutil/trace.go:171","msg":"trace[351722392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"378.076601ms","start":"2026-02-20T16:06:02.873923Z","end":"2026-02-20T16:06:03.252Z","steps":["trace[351722392] 'range keys from in-memory index tree'  (duration: 377.851406ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:03.251927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.611434ms","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-20T16:06:03.252172Z","caller":"traceutil/trace.go:171","msg":"trace[104259964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:776; }","duration":"120.923721ms","start":"2026-02-20T16:06:03.131221Z","end":"2026-02-20T16:06:03.252145Z","steps":["trace[104259964] 'range keys from in-memory index tree'  (duration: 120.398579ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:03.252081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:02.873899Z","time spent":"378.168073ms","remote":"127.0.0.1:38330","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-20T16:06:03.252372Z","caller":"traceutil/trace.go:171","msg":"trace[65238960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:776; }","duration":"191.250011ms","start":"2026-02-20T16:06:03.060804Z","end":"2026-02-20T16:06:03.252054Z","steps":["trace[65238960] 'range keys from in-memory index tree'  (duration: 190.984634ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:03.378605Z","caller":"traceutil/trace.go:171","msg":"trace[1737651914] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"121.669281ms","start":"2026-02-20T16:06:03.256918Z","end":"2026-02-20T16:06:03.378588Z","steps":["trace[1737651914] 'process raft request'  (duration: 121.556358ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.188803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.516248ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291818950 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:770 > 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-20T16:06:04.189194Z","caller":"traceutil/trace.go:171","msg":"trace[1886820863] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:808; }","duration":"864.646141ms","start":"2026-02-20T16:06:03.324525Z","end":"2026-02-20T16:06:04.189171Z","steps":["trace[1886820863] 'read index received'  (duration: 53.919367ms)","trace[1886820863] 'applied index is now lower than readState.Index'  (duration: 810.724794ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:04.189278Z","caller":"traceutil/trace.go:171","msg":"trace[136472259] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"932.224191ms","start":"2026-02-20T16:06:03.257017Z","end":"2026-02-20T16:06:04.189241Z","steps":["trace[136472259] 'process raft request'  (duration: 250.884962ms)","trace[136472259] 'compare'  (duration: 679.929763ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:04.189492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:03.256991Z","time spent":"932.396335ms","remote":"127.0.0.1:38568","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:770 > 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-20T16:06:04.189502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.980499ms","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-20T16:06:04.189553Z","caller":"traceutil/trace.go:171","msg":"trace[1590137063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:778; }","duration":"865.067041ms","start":"2026-02-20T16:06:03.324473Z","end":"2026-02-20T16:06:04.18954Z","steps":["trace[1590137063] 'agreement among raft nodes before linearized reading'  (duration: 864.887887ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.189599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:03.324454Z","time spent":"865.136044ms","remote":"127.0.0.1:38568","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-20T16:06:04.328785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.688478ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291818951 > lease_revoke:<id:2e799c7bcb93c162>","response":"size:27"}
{"level":"info","ts":"2026-02-20T16:06:04.329045Z","caller":"traceutil/trace.go:171","msg":"trace[896233320] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"134.864023ms","start":"2026-02-20T16:06:04.194162Z","end":"2026-02-20T16:06:04.329026Z","steps":["trace[896233320] 'process raft request'  (duration: 134.73518ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:04.329185Z","caller":"traceutil/trace.go:171","msg":"trace[132453471] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"139.830638ms","start":"2026-02-20T16:06:04.189254Z","end":"2026-02-20T16:06:04.329084Z","steps":["trace[132453471] 'read index received'  (duration: 4.775021ms)","trace[132453471] 'applied index is now lower than readState.Index'  (duration: 135.052477ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:04.329609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.185445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-20T16:06:04.329655Z","caller":"traceutil/trace.go:171","msg":"trace[804639677] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:779; }","duration":"357.281577ms","start":"2026-02-20T16:06:03.972361Z","end":"2026-02-20T16:06:04.329642Z","steps":["trace[804639677] 'agreement among raft nodes before linearized reading'  (duration: 357.157684ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.32969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:03.972334Z","time spent":"357.34593ms","remote":"127.0.0.1:38396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":78,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T16:06:04.329695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005000143s","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-20T16:06:04.329774Z","caller":"traceutil/trace.go:171","msg":"trace[1592847747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:779; }","duration":"1.005134486s","start":"2026-02-20T16:06:03.324621Z","end":"2026-02-20T16:06:04.329755Z","steps":["trace[1592847747] 'agreement among raft nodes before linearized reading'  (duration: 1.004861119s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.329782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005206798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-20T16:06:04.32983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:03.324601Z","time spent":"1.005220268s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:06:04.329856Z","caller":"traceutil/trace.go:171","msg":"trace[1348159881] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:779; }","duration":"1.005369441s","start":"2026-02-20T16:06:03.324474Z","end":"2026-02-20T16:06:04.329843Z","steps":["trace[1348159881] 'agreement among raft nodes before linearized reading'  (duration: 1.004995462s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.329955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:03.324462Z","time spent":"1.005481765s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:06:04.329591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.481458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:04.330176Z","caller":"traceutil/trace.go:171","msg":"trace[1294770762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"454.151575ms","start":"2026-02-20T16:06:03.875967Z","end":"2026-02-20T16:06:04.330119Z","steps":["trace[1294770762] 'agreement among raft nodes before linearized reading'  (duration: 453.444017ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.330324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:03.875871Z","time spent":"454.435112ms","remote":"127.0.0.1:38322","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-20T16:06:04.75758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.834234ms","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-20T16:06:04.757792Z","caller":"traceutil/trace.go:171","msg":"trace[1083585915] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:780; }","duration":"184.06334ms","start":"2026-02-20T16:06:04.573709Z","end":"2026-02-20T16:06:04.757773Z","steps":["trace[1083585915] 'range keys from in-memory index tree'  (duration: 183.812084ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:04.807475Z","caller":"traceutil/trace.go:171","msg":"trace[478256057] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"472.721562ms","start":"2026-02-20T16:06:04.33473Z","end":"2026-02-20T16:06:04.807451Z","steps":["trace[478256057] 'process raft request'  (duration: 472.566728ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:04.807695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:04.334717Z","time spent":"472.893056ms","remote":"127.0.0.1:38568","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:774 > 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-20T16:06:15.175386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.267066ms","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-20T16:06:15.175524Z","caller":"traceutil/trace.go:171","msg":"trace[1940565769] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:858; }","duration":"601.43332ms","start":"2026-02-20T16:06:14.574073Z","end":"2026-02-20T16:06:15.175507Z","steps":["trace[1940565769] 'range keys from in-memory index tree'  (duration: 601.250405ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:15.175825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.023053ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291819125 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:802 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T16:06:15.17592Z","caller":"traceutil/trace.go:171","msg":"trace[607669484] linearizableReadLoop","detail":"{readStateIndex:896; appliedIndex:895; }","duration":"331.11162ms","start":"2026-02-20T16:06:14.844791Z","end":"2026-02-20T16:06:15.175903Z","steps":["trace[607669484] 'read index received'  (duration: 46.302µs)","trace[607669484] 'applied index is now lower than readState.Index'  (duration: 331.063588ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:15.176009Z","caller":"traceutil/trace.go:171","msg":"trace[400866395] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"692.382807ms","start":"2026-02-20T16:06:14.483615Z","end":"2026-02-20T16:06:15.175998Z","steps":["trace[400866395] 'process raft request'  (duration: 199.106398ms)","trace[400866395] 'compare'  (duration: 492.537251ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:15.176071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:14.483595Z","time spent":"692.446689ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:802 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-20T16:06:15.176102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.321314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:15.176155Z","caller":"traceutil/trace.go:171","msg":"trace[768652075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:859; }","duration":"300.407167ms","start":"2026-02-20T16:06:14.875732Z","end":"2026-02-20T16:06:15.176139Z","steps":["trace[768652075] 'agreement among raft nodes before linearized reading'  (duration: 300.314084ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:15.176141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.352615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-20T16:06:15.176188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:14.875716Z","time spent":"300.465128ms","remote":"127.0.0.1:38322","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-20T16:06:15.176197Z","caller":"traceutil/trace.go:171","msg":"trace[822327183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:859; }","duration":"331.454648ms","start":"2026-02-20T16:06:14.844729Z","end":"2026-02-20T16:06:15.176183Z","steps":["trace[822327183] 'agreement among raft nodes before linearized reading'  (duration: 331.314254ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:15.176234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:14.844699Z","time spent":"331.52666ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:06:27.790865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819225,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:06:28.291266Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819225,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:06:28.589354Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.362178326s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-20T16:06:28.589817Z","caller":"traceutil/trace.go:171","msg":"trace[2113845685] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:930; }","duration":"1.299371537s","start":"2026-02-20T16:06:27.290419Z","end":"2026-02-20T16:06:28.58979Z","steps":["trace[2113845685] 'read index received'  (duration: 1.299134491s)","trace[2113845685] 'applied index is now lower than readState.Index'  (duration: 235.936µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:28.589864Z","caller":"traceutil/trace.go:171","msg":"trace[489659054] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"1.362754421s","start":"2026-02-20T16:06:27.227082Z","end":"2026-02-20T16:06:28.589836Z","steps":["trace[489659054] 'process raft request'  (duration: 1.362521685s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:28.590044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293598632s","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-20T16:06:28.590126Z","caller":"traceutil/trace.go:171","msg":"trace[1423809729] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:892; }","duration":"1.293717815s","start":"2026-02-20T16:06:27.296389Z","end":"2026-02-20T16:06:28.590107Z","steps":["trace[1423809729] 'agreement among raft nodes before linearized reading'  (duration: 1.293570471s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:28.590172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:27.296378Z","time spent":"1.293783456s","remote":"127.0.0.1:38664","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":"warn","ts":"2026-02-20T16:06:28.590163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215252621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-20T16:06:28.590164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.55014ms","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-20T16:06:28.590231Z","caller":"traceutil/trace.go:171","msg":"trace[5352036] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:892; }","duration":"1.215389254s","start":"2026-02-20T16:06:27.374828Z","end":"2026-02-20T16:06:28.590217Z","steps":["trace[5352036] 'agreement among raft nodes before linearized reading'  (duration: 1.215231191s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:28.590054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299641444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-20T16:06:28.590255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.332265ms","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":"warn","ts":"2026-02-20T16:06:28.590269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:27.374808Z","time spent":"1.215451366s","remote":"127.0.0.1:38486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"info","ts":"2026-02-20T16:06:28.590314Z","caller":"traceutil/trace.go:171","msg":"trace[1926638345] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:892; }","duration":"816.435777ms","start":"2026-02-20T16:06:27.773864Z","end":"2026-02-20T16:06:28.590299Z","steps":["trace[1926638345] 'agreement among raft nodes before linearized reading'  (duration: 816.358536ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:28.590164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105235302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-20T16:06:28.590363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:27.773844Z","time spent":"816.493269ms","remote":"127.0.0.1:38722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-02-20T16:06:28.590395Z","caller":"traceutil/trace.go:171","msg":"trace[1468866098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:892; }","duration":"1.10551595s","start":"2026-02-20T16:06:27.484869Z","end":"2026-02-20T16:06:28.590385Z","steps":["trace[1468866098] 'agreement among raft nodes before linearized reading'  (duration: 1.105168961s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:28.590436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:27.484843Z","time spent":"1.105582081s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-20T16:06:28.590257Z","caller":"traceutil/trace.go:171","msg":"trace[1110689911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:892; }","duration":"296.680063ms","start":"2026-02-20T16:06:28.293559Z","end":"2026-02-20T16:06:28.590239Z","steps":["trace[1110689911] 'agreement among raft nodes before linearized reading'  (duration: 296.449907ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:28.59038Z","caller":"traceutil/trace.go:171","msg":"trace[1381722920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:892; }","duration":"1.299963221s","start":"2026-02-20T16:06:27.290366Z","end":"2026-02-20T16:06:28.590329Z","steps":["trace[1381722920] 'agreement among raft nodes before linearized reading'  (duration: 1.299536711s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:28.590565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:27.227064Z","time spent":"1.362851753s","remote":"127.0.0.1:38568","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:887 > 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-20T16:06:28.590595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:27.290349Z","time spent":"1.300216938s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:06:29.355149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.126756ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291819230 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:2e799c7bcb93c2dd>","response":"size:39"}
{"level":"info","ts":"2026-02-20T16:06:29.355501Z","caller":"traceutil/trace.go:171","msg":"trace[1798065061] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"760.851499ms","start":"2026-02-20T16:06:28.594632Z","end":"2026-02-20T16:06:29.355483Z","steps":["trace[1798065061] 'process raft request'  (duration: 760.759817ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:29.35561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:28.594625Z","time spent":"760.921511ms","remote":"127.0.0.1:38568","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:889 > 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-20T16:06:29.355688Z","caller":"traceutil/trace.go:171","msg":"trace[1821129071] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"761.371374ms","start":"2026-02-20T16:06:28.594292Z","end":"2026-02-20T16:06:29.355663Z","steps":["trace[1821129071] 'process raft request'  (duration: 760.960493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:29.355815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:28.594279Z","time spent":"761.466936ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:890 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:06:29.355796Z","caller":"traceutil/trace.go:171","msg":"trace[779401293] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"761.100497ms","start":"2026-02-20T16:06:28.594666Z","end":"2026-02-20T16:06:29.355766Z","steps":["trace[779401293] 'process raft request'  (duration: 760.778828ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:29.355864Z","caller":"traceutil/trace.go:171","msg":"trace[1166169648] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:931; }","duration":"481.911343ms","start":"2026-02-20T16:06:28.873929Z","end":"2026-02-20T16:06:29.35584Z","steps":["trace[1166169648] 'read index received'  (duration: 311.426274ms)","trace[1166169648] 'applied index is now lower than readState.Index'  (duration: 170.483859ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:29.355948Z","caller":"traceutil/trace.go:171","msg":"trace[1621087404] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"760.649506ms","start":"2026-02-20T16:06:28.595286Z","end":"2026-02-20T16:06:29.355936Z","steps":["trace[1621087404] 'process raft request'  (duration: 760.383579ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:29.355967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.031336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:29.356025Z","caller":"traceutil/trace.go:171","msg":"trace[1384100807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:896; }","duration":"482.125528ms","start":"2026-02-20T16:06:28.873881Z","end":"2026-02-20T16:06:29.356006Z","steps":["trace[1384100807] 'agreement among raft nodes before linearized reading'  (duration: 482.038456ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:29.35606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:28.595277Z","time spent":"760.724117ms","remote":"127.0.0.1:38568","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:891 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:06:29.356069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:28.873861Z","time spent":"482.196501ms","remote":"127.0.0.1:38322","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-20T16:06:29.355946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:28.594653Z","time spent":"761.21ms","remote":"127.0.0.1:38568","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:888 > 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-20T16:06:29.355402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:28.591251Z","time spent":"764.143342ms","remote":"127.0.0.1:38346","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-20T16:06:43.973905Z","caller":"traceutil/trace.go:171","msg":"trace[1705395810] linearizableReadLoop","detail":"{readStateIndex:1000; appliedIndex:999; }","duration":"100.029746ms","start":"2026-02-20T16:06:43.873846Z","end":"2026-02-20T16:06:43.973876Z","steps":["trace[1705395810] 'read index received'  (duration: 26.305481ms)","trace[1705395810] 'applied index is now lower than readState.Index'  (duration: 73.722735ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:43.974036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.171101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:43.974112Z","caller":"traceutil/trace.go:171","msg":"trace[346814254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"100.292373ms","start":"2026-02-20T16:06:43.873805Z","end":"2026-02-20T16:06:43.974097Z","steps":["trace[346814254] 'agreement among raft nodes before linearized reading'  (duration: 100.16557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:45.960503Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819383,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:06:46.14792Z","caller":"traceutil/trace.go:171","msg":"trace[467958112] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"687.603889ms","start":"2026-02-20T16:06:45.460291Z","end":"2026-02-20T16:06:46.147895Z","steps":["trace[467958112] 'read index received'  (duration: 687.377363ms)","trace[467958112] 'applied index is now lower than readState.Index'  (duration: 225.696µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:46.148007Z","caller":"traceutil/trace.go:171","msg":"trace[721927371] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"688.952213ms","start":"2026-02-20T16:06:45.459019Z","end":"2026-02-20T16:06:46.147972Z","steps":["trace[721927371] 'process raft request'  (duration: 688.712787ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:46.148169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.849866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-20T16:06:46.148197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:45.458998Z","time spent":"689.083796ms","remote":"127.0.0.1:38568","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:948 > 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-20T16:06:46.148214Z","caller":"traceutil/trace.go:171","msg":"trace[361389491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:959; }","duration":"687.914587ms","start":"2026-02-20T16:06:45.460287Z","end":"2026-02-20T16:06:46.148201Z","steps":["trace[361389491] 'agreement among raft nodes before linearized reading'  (duration: 687.748883ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:46.148256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:45.46024Z","time spent":"688.00766ms","remote":"127.0.0.1:38568","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-20T16:06:46.148381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.043635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:46.148425Z","caller":"traceutil/trace.go:171","msg":"trace[494208909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:959; }","duration":"274.109516ms","start":"2026-02-20T16:06:45.874298Z","end":"2026-02-20T16:06:46.148408Z","steps":["trace[494208909] 'agreement among raft nodes before linearized reading'  (duration: 274.042714ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:46.148797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.45899ms","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-20T16:06:46.148915Z","caller":"traceutil/trace.go:171","msg":"trace[1580721893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:959; }","duration":"682.655054ms","start":"2026-02-20T16:06:45.466235Z","end":"2026-02-20T16:06:46.14889Z","steps":["trace[1580721893] 'agreement among raft nodes before linearized reading'  (duration: 682.153322ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:46.148971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:45.466222Z","time spent":"682.737946ms","remote":"127.0.0.1:38568","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-20T16:06:46.149051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.693435ms","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-20T16:06:46.149162Z","caller":"traceutil/trace.go:171","msg":"trace[1523346949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:959; }","duration":"684.978053ms","start":"2026-02-20T16:06:45.464159Z","end":"2026-02-20T16:06:46.149137Z","steps":["trace[1523346949] 'agreement among raft nodes before linearized reading'  (duration: 684.150302ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:46.149247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:45.464151Z","time spent":"685.081285ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-20T16:06:47.581007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.524313ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291819387 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T16:06:47.581113Z","caller":"traceutil/trace.go:171","msg":"trace[1895968550] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"1.427598961s","start":"2026-02-20T16:06:46.153493Z","end":"2026-02-20T16:06:47.581092Z","steps":["trace[1895968550] 'process raft request'  (duration: 718.910194ms)","trace[1895968550] 'compare'  (duration: 708.288107ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:47.581173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:46.15347Z","time spent":"1.427672783s","remote":"127.0.0.1:38568","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:952 > 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-20T16:06:47.591484Z","caller":"traceutil/trace.go:171","msg":"trace[989463986] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1002; }","duration":"869.615175ms","start":"2026-02-20T16:06:46.72184Z","end":"2026-02-20T16:06:47.591455Z","steps":["trace[989463986] 'read index received'  (duration: 150.576657ms)","trace[989463986] 'applied index is now lower than readState.Index'  (duration: 719.037228ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:47.591522Z","caller":"traceutil/trace.go:171","msg":"trace[1397572516] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"1.436771313s","start":"2026-02-20T16:06:46.154719Z","end":"2026-02-20T16:06:47.59149Z","steps":["trace[1397572516] 'process raft request'  (duration: 1.436545507s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:47.591663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.099704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:06:47.591668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:46.154709Z","time spent":"1.436880735s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:06:47.591548Z","caller":"traceutil/trace.go:171","msg":"trace[787595547] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"1.436697701s","start":"2026-02-20T16:06:46.154825Z","end":"2026-02-20T16:06:47.591523Z","steps":["trace[787595547] 'process raft request'  (duration: 1.436583138s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:47.591786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.613999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:47.59171Z","caller":"traceutil/trace.go:171","msg":"trace[421796375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"718.193296ms","start":"2026-02-20T16:06:46.873499Z","end":"2026-02-20T16:06:47.591692Z","steps":["trace[421796375] 'agreement among raft nodes before linearized reading'  (duration: 718.112054ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:47.591841Z","caller":"traceutil/trace.go:171","msg":"trace[1203470419] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:962; }","duration":"307.728341ms","start":"2026-02-20T16:06:47.284098Z","end":"2026-02-20T16:06:47.591826Z","steps":["trace[1203470419] 'agreement among raft nodes before linearized reading'  (duration: 307.633919ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:47.591883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:47.284073Z","time spent":"307.800473ms","remote":"127.0.0.1:47184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T16:06:47.591882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:46.873478Z","time spent":"718.391981ms","remote":"127.0.0.1:38322","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-20T16:06:47.591908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.706018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-20T16:06:47.59175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.892462ms","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-20T16:06:47.592005Z","caller":"traceutil/trace.go:171","msg":"trace[1034707754] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:962; }","duration":"291.900033ms","start":"2026-02-20T16:06:47.300089Z","end":"2026-02-20T16:06:47.591989Z","steps":["trace[1034707754] 'agreement among raft nodes before linearized reading'  (duration: 291.632187ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:47.592026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:46.154771Z","time spent":"1.437126562s","remote":"127.0.0.1:38568","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:950 > 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-20T16:06:47.592078Z","caller":"traceutil/trace.go:171","msg":"trace[1616622014] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:962; }","duration":"870.268751ms","start":"2026-02-20T16:06:46.721793Z","end":"2026-02-20T16:06:47.592061Z","steps":["trace[1616622014] 'agreement among raft nodes before linearized reading'  (duration: 869.786669ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:47.592174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:46.721771Z","time spent":"870.391915ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T16:06:49.526427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.581336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:49.526509Z","caller":"traceutil/trace.go:171","msg":"trace[1259593231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"652.71361ms","start":"2026-02-20T16:06:48.873776Z","end":"2026-02-20T16:06:49.526489Z","steps":["trace[1259593231] 'range keys from in-memory index tree'  (duration: 652.462124ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:49.526506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.968646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:06:49.526548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:48.873752Z","time spent":"652.787892ms","remote":"127.0.0.1:38330","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-20T16:06:49.52658Z","caller":"traceutil/trace.go:171","msg":"trace[1628669706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"556.09091ms","start":"2026-02-20T16:06:48.97047Z","end":"2026-02-20T16:06:49.52656Z","steps":["trace[1628669706] 'range keys from in-memory index tree'  (duration: 555.869504ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:49.526627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:48.970448Z","time spent":"556.165922ms","remote":"127.0.0.1:38322","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-20T16:06:50.096006Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819408,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:06:50.596396Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819408,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:06:50.655174Z","caller":"traceutil/trace.go:171","msg":"trace[1532301938] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"1.05941259s","start":"2026-02-20T16:06:49.595737Z","end":"2026-02-20T16:06:50.65515Z","steps":["trace[1532301938] 'read index received'  (duration: 1.059196585s)","trace[1532301938] 'applied index is now lower than readState.Index'  (duration: 214.805µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:50.655285Z","caller":"traceutil/trace.go:171","msg":"trace[816517637] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"1.066603981s","start":"2026-02-20T16:06:49.588672Z","end":"2026-02-20T16:06:50.655276Z","steps":["trace[816517637] 'process raft request'  (duration: 1.066337075s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:50.655466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:49.588655Z","time spent":"1.066659673s","remote":"127.0.0.1:38568","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:960 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:06:50.655562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059539443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-02-20T16:06:50.655574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006995112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-20T16:06:50.655585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.771044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-20T16:06:50.655629Z","caller":"traceutil/trace.go:171","msg":"trace[1071441540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:967; }","duration":"1.007075935s","start":"2026-02-20T16:06:49.64854Z","end":"2026-02-20T16:06:50.655615Z","steps":["trace[1071441540] 'agreement among raft nodes before linearized reading'  (duration: 1.006934441s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:50.655628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059881142s","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-20T16:06:50.655651Z","caller":"traceutil/trace.go:171","msg":"trace[789505311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:967; }","duration":"478.881877ms","start":"2026-02-20T16:06:50.176751Z","end":"2026-02-20T16:06:50.655633Z","steps":["trace[789505311] 'agreement among raft nodes before linearized reading'  (duration: 478.672712ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:50.655671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:49.648528Z","time spent":"1.007134656s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:06:50.655689Z","caller":"traceutil/trace.go:171","msg":"trace[455821708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"1.059974594s","start":"2026-02-20T16:06:49.595697Z","end":"2026-02-20T16:06:50.655672Z","steps":["trace[455821708] 'agreement among raft nodes before linearized reading'  (duration: 1.05982648s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:50.655701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:50.176728Z","time spent":"478.960578ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:06:50.655736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:49.595679Z","time spent":"1.060041656s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-20T16:06:50.655628Z","caller":"traceutil/trace.go:171","msg":"trace[1398493480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"1.059654766s","start":"2026-02-20T16:06:49.595952Z","end":"2026-02-20T16:06:50.655607Z","steps":["trace[1398493480] 'agreement among raft nodes before linearized reading'  (duration: 1.059429091s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:50.655836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:49.595933Z","time spent":"1.059883122s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-20T16:06:50.865605Z","caller":"traceutil/trace.go:171","msg":"trace[1284573338] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"203.90291ms","start":"2026-02-20T16:06:50.661685Z","end":"2026-02-20T16:06:50.865588Z","steps":["trace[1284573338] 'process raft request'  (duration: 203.872789ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:50.865657Z","caller":"traceutil/trace.go:171","msg":"trace[628037838] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"204.530275ms","start":"2026-02-20T16:06:50.661113Z","end":"2026-02-20T16:06:50.865643Z","steps":["trace[628037838] 'process raft request'  (duration: 152.29039ms)","trace[628037838] 'compare'  (duration: 52.04625ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:50.865813Z","caller":"traceutil/trace.go:171","msg":"trace[35635303] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"204.590067ms","start":"2026-02-20T16:06:50.661214Z","end":"2026-02-20T16:06:50.865804Z","steps":["trace[35635303] 'process raft request'  (duration: 204.31484ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:51.13206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.346793ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291819418 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-vtmp2.1896001908f9bbdd\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-vtmp2.1896001908f9bbdd\" value_size:685 lease:3348879853437043266 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-20T16:06:51.132312Z","caller":"traceutil/trace.go:171","msg":"trace[887428154] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"187.776334ms","start":"2026-02-20T16:06:50.944507Z","end":"2026-02-20T16:06:51.132284Z","steps":["trace[887428154] 'process raft request'  (duration: 31.130803ms)","trace[887428154] 'compare'  (duration: 155.849551ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:51.434305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.372187ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291819421 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:403 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-20T16:06:51.434479Z","caller":"traceutil/trace.go:171","msg":"trace[498588806] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1016; }","duration":"214.927837ms","start":"2026-02-20T16:06:51.219533Z","end":"2026-02-20T16:06:51.434461Z","steps":["trace[498588806] 'read index received'  (duration: 40.332865ms)","trace[498588806] 'applied index is now lower than readState.Index'  (duration: 174.594112ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:51.434607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.068441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:51.434642Z","caller":"traceutil/trace.go:171","msg":"trace[1525030168] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:974; }","duration":"215.146263ms","start":"2026-02-20T16:06:51.219484Z","end":"2026-02-20T16:06:51.43463Z","steps":["trace[1525030168] 'agreement among raft nodes before linearized reading'  (duration: 215.04341ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:51.434627Z","caller":"traceutil/trace.go:171","msg":"trace[1638846127] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"293.238407ms","start":"2026-02-20T16:06:51.141362Z","end":"2026-02-20T16:06:51.434601Z","steps":["trace[1638846127] 'process raft request'  (duration: 118.496801ms)","trace[1638846127] 'compare'  (duration: 174.257894ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:51.434726Z","caller":"traceutil/trace.go:171","msg":"trace[1360936906] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"225.218656ms","start":"2026-02-20T16:06:51.209453Z","end":"2026-02-20T16:06:51.434672Z","steps":["trace[1360936906] 'process raft request'  (duration: 224.959729ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:51.742612Z","caller":"traceutil/trace.go:171","msg":"trace[91203139] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"301.927575ms","start":"2026-02-20T16:06:51.440655Z","end":"2026-02-20T16:06:51.742583Z","steps":["trace[91203139] 'process raft request'  (duration: 228.16134ms)","trace[91203139] 'compare'  (duration: 73.627422ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:51.742755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:51.44064Z","time spent":"302.053008ms","remote":"127.0.0.1:38396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.1896001926894490\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.1896001926894490\" value_size:689 lease:3348879853437043266 >> failure:<>"}
{"level":"info","ts":"2026-02-20T16:06:51.751551Z","caller":"traceutil/trace.go:171","msg":"trace[1222607899] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"247.132936ms","start":"2026-02-20T16:06:51.504399Z","end":"2026-02-20T16:06:51.751532Z","steps":["trace[1222607899] 'process raft request'  (duration: 247.031454ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:52.107064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.074093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:52.107157Z","caller":"traceutil/trace.go:171","msg":"trace[1734473991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"233.242317ms","start":"2026-02-20T16:06:51.873896Z","end":"2026-02-20T16:06:52.107138Z","steps":["trace[1734473991] 'range keys from in-memory index tree'  (duration: 232.984151ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:52.608324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819428,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:06:52.672749Z","caller":"traceutil/trace.go:171","msg":"trace[1425143713] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"564.671206ms","start":"2026-02-20T16:06:52.108054Z","end":"2026-02-20T16:06:52.672725Z","steps":["trace[1425143713] 'read index received'  (duration: 564.480191ms)","trace[1425143713] 'applied index is now lower than readState.Index'  (duration: 190.115µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:52.672865Z","caller":"traceutil/trace.go:171","msg":"trace[1993519866] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"612.443847ms","start":"2026-02-20T16:06:52.060412Z","end":"2026-02-20T16:06:52.672856Z","steps":["trace[1993519866] 'process raft request'  (duration: 612.17195ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:52.672972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:52.06039Z","time spent":"612.502899ms","remote":"127.0.0.1:38568","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:939 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-20T16:06:52.673191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.124487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:52.673248Z","caller":"traceutil/trace.go:171","msg":"trace[198064264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:978; }","duration":"565.208939ms","start":"2026-02-20T16:06:52.108026Z","end":"2026-02-20T16:06:52.673235Z","steps":["trace[198064264] 'agreement among raft nodes before linearized reading'  (duration: 565.098427ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:52.673343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:52.108016Z","time spent":"565.295431ms","remote":"127.0.0.1:38330","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-20T16:06:52.919197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.079983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-20T16:06:52.919273Z","caller":"traceutil/trace.go:171","msg":"trace[638387702] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:979; }","duration":"202.192766ms","start":"2026-02-20T16:06:52.717063Z","end":"2026-02-20T16:06:52.919256Z","steps":["trace[638387702] 'range keys from in-memory index tree'  (duration: 201.93639ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:53.579371Z","caller":"traceutil/trace.go:171","msg":"trace[1641173640] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"655.50933ms","start":"2026-02-20T16:06:52.923823Z","end":"2026-02-20T16:06:53.579333Z","steps":["trace[1641173640] 'process raft request'  (duration: 655.436388ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:53.579527Z","caller":"traceutil/trace.go:171","msg":"trace[971819377] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"655.605522ms","start":"2026-02-20T16:06:52.923908Z","end":"2026-02-20T16:06:53.579513Z","steps":["trace[971819377] 'process raft request'  (duration: 655.392197ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:53.579643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:52.923802Z","time spent":"655.724085ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:970 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-20T16:06:53.579392Z","caller":"traceutil/trace.go:171","msg":"trace[872077449] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"655.972493ms","start":"2026-02-20T16:06:52.923361Z","end":"2026-02-20T16:06:53.579333Z","steps":["trace[872077449] 'process raft request'  (duration: 655.696245ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:53.579819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:52.92333Z","time spent":"656.440644ms","remote":"127.0.0.1:38568","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:968 > 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-20T16:06:53.579963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:52.923898Z","time spent":"655.757497ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:971 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:06:53.993471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.723916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:53.993548Z","caller":"traceutil/trace.go:171","msg":"trace[763149248] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:983; }","duration":"118.849499ms","start":"2026-02-20T16:06:53.87468Z","end":"2026-02-20T16:06:53.99353Z","steps":["trace[763149248] 'range keys from in-memory index tree'  (duration: 118.655775ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:54.212522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.026291ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12572251890291819442 > lease_revoke:<id:2e799c7bcb93c328>","response":"size:27"}
{"level":"info","ts":"2026-02-20T16:06:54.213341Z","caller":"traceutil/trace.go:171","msg":"trace[31046676] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"230.994021ms","start":"2026-02-20T16:06:53.982305Z","end":"2026-02-20T16:06:54.213299Z","steps":["trace[31046676] 'process raft request'  (duration: 230.302654ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:54.213322Z","caller":"traceutil/trace.go:171","msg":"trace[221418731] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1027; }","duration":"218.66663ms","start":"2026-02-20T16:06:53.994631Z","end":"2026-02-20T16:06:54.213297Z","steps":["trace[221418731] 'read index received'  (duration: 52.825629ms)","trace[221418731] 'applied index is now lower than readState.Index'  (duration: 165.839201ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:54.341571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.899867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:54.341663Z","caller":"traceutil/trace.go:171","msg":"trace[611038227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:984; }","duration":"347.05518ms","start":"2026-02-20T16:06:53.994584Z","end":"2026-02-20T16:06:54.34164Z","steps":["trace[611038227] 'agreement among raft nodes before linearized reading'  (duration: 218.785043ms)","trace[611038227] 'range keys from in-memory index tree'  (duration: 128.030741ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:54.341736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:53.994566Z","time spent":"347.135773ms","remote":"127.0.0.1:38330","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-20T16:06:55.509422Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12572251890291819445,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:06:55.848574Z","caller":"traceutil/trace.go:171","msg":"trace[169379143] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"840.141235ms","start":"2026-02-20T16:06:55.008414Z","end":"2026-02-20T16:06:55.848555Z","steps":["trace[169379143] 'read index received'  (duration: 839.92949ms)","trace[169379143] 'applied index is now lower than readState.Index'  (duration: 211.105µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:55.848713Z","caller":"traceutil/trace.go:171","msg":"trace[858499483] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.142242224s","start":"2026-02-20T16:06:54.706438Z","end":"2026-02-20T16:06:55.84868Z","steps":["trace[858499483] 'process raft request'  (duration: 1.141913006s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:55.848882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:54.706412Z","time spent":"1.142378568s","remote":"127.0.0.1:38568","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:979 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:06:56.064531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056084727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-20T16:06:56.064583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.235192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-20T16:06:56.064571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.43288ms","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-20T16:06:56.064617Z","caller":"traceutil/trace.go:171","msg":"trace[1483493991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:985; }","duration":"1.05621442s","start":"2026-02-20T16:06:55.008381Z","end":"2026-02-20T16:06:56.064596Z","steps":["trace[1483493991] 'agreement among raft nodes before linearized reading'  (duration: 840.394851ms)","trace[1483493991] 'range keys from in-memory index tree'  (duration: 215.570223ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:56.064651Z","caller":"traceutil/trace.go:171","msg":"trace[315983717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:985; }","duration":"480.341814ms","start":"2026-02-20T16:06:55.58429Z","end":"2026-02-20T16:06:56.064631Z","steps":["trace[315983717] 'agreement among raft nodes before linearized reading'  (duration: 264.500915ms)","trace[315983717] 'range keys from in-memory index tree'  (duration: 215.686966ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:56.064674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:55.008367Z","time spent":"1.056294382s","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-20T16:06:56.064664Z","caller":"traceutil/trace.go:171","msg":"trace[1036070724] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:985; }","duration":"479.568043ms","start":"2026-02-20T16:06:55.58507Z","end":"2026-02-20T16:06:56.064638Z","steps":["trace[1036070724] 'agreement among raft nodes before linearized reading'  (duration: 263.727074ms)","trace[1036070724] 'range keys from in-memory index tree'  (duration: 215.636055ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:56.064695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:55.584267Z","time spent":"480.418806ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T16:06:56.06472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:55.58505Z","time spent":"479.660816ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-20T16:06:56.064721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.342824ms","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-20T16:06:56.064795Z","caller":"traceutil/trace.go:171","msg":"trace[1903102619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:985; }","duration":"480.459557ms","start":"2026-02-20T16:06:55.584315Z","end":"2026-02-20T16:06:56.064774Z","steps":["trace[1903102619] 'agreement among raft nodes before linearized reading'  (duration: 264.490334ms)","trace[1903102619] 'range keys from in-memory index tree'  (duration: 215.781618ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:06:56.064811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.788686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:06:56.064836Z","caller":"traceutil/trace.go:171","msg":"trace[92095497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"191.811116ms","start":"2026-02-20T16:06:55.873016Z","end":"2026-02-20T16:06:56.064827Z","steps":["trace[92095497] 'range keys from in-memory index tree'  (duration: 191.745045ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:56.064835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:06:55.584293Z","time spent":"480.533479ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-20T16:06:58.337779Z","caller":"traceutil/trace.go:171","msg":"trace[1509691342] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1036; }","duration":"232.233282ms","start":"2026-02-20T16:06:58.105523Z","end":"2026-02-20T16:06:58.337756Z","steps":["trace[1509691342] 'read index received'  (duration: 231.980586ms)","trace[1509691342] 'applied index is now lower than readState.Index'  (duration: 251.806µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:06:58.337859Z","caller":"traceutil/trace.go:171","msg":"trace[438791281] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"232.96477ms","start":"2026-02-20T16:06:58.104884Z","end":"2026-02-20T16:06:58.337849Z","steps":["trace[438791281] 'process raft request'  (duration: 232.738085ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:58.338001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.923885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-20T16:06:58.338003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.467768ms","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-20T16:06:58.338035Z","caller":"traceutil/trace.go:171","msg":"trace[1773999539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:992; }","duration":"231.977436ms","start":"2026-02-20T16:06:58.106047Z","end":"2026-02-20T16:06:58.338025Z","steps":["trace[1773999539] 'agreement among raft nodes before linearized reading'  (duration: 231.830592ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:06:58.338053Z","caller":"traceutil/trace.go:171","msg":"trace[35599222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:992; }","duration":"232.54674ms","start":"2026-02-20T16:06:58.10549Z","end":"2026-02-20T16:06:58.338037Z","steps":["trace[35599222] 'agreement among raft nodes before linearized reading'  (duration: 232.385166ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:06:58.338503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.996335ms","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-20T16:06:58.338596Z","caller":"traceutil/trace.go:171","msg":"trace[1499860351] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:992; }","duration":"232.110898ms","start":"2026-02-20T16:06:58.106465Z","end":"2026-02-20T16:06:58.338576Z","steps":["trace[1499860351] 'agreement among raft nodes before linearized reading'  (duration: 231.485532ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:07:10.734762Z","caller":"traceutil/trace.go:171","msg":"trace[227349770] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1113; }","duration":"342.412213ms","start":"2026-02-20T16:07:10.392326Z","end":"2026-02-20T16:07:10.734738Z","steps":["trace[227349770] 'read index received'  (duration: 342.376552ms)","trace[227349770] 'applied index is now lower than readState.Index'  (duration: 34.481µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:07:10.73484Z","caller":"traceutil/trace.go:171","msg":"trace[1709742157] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"342.559437ms","start":"2026-02-20T16:07:10.392222Z","end":"2026-02-20T16:07:10.734782Z","steps":["trace[1709742157] 'process raft request'  (duration: 342.370293ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:07:10.735006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.661451ms","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-20T16:07:10.735051Z","caller":"traceutil/trace.go:171","msg":"trace[2035213257] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1066; }","duration":"342.745333ms","start":"2026-02-20T16:07:10.392294Z","end":"2026-02-20T16:07:10.73504Z","steps":["trace[2035213257] 'agreement among raft nodes before linearized reading'  (duration: 342.591749ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:07:10.73509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:07:10.392287Z","time spent":"342.792864ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-20T16:07:10.735088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:07:10.392194Z","time spent":"342.804185ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1058 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-20T16:07:10.736465Z","caller":"traceutil/trace.go:171","msg":"trace[215408108] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"331.999482ms","start":"2026-02-20T16:07:10.404448Z","end":"2026-02-20T16:07:10.736448Z","steps":["trace[215408108] 'process raft request'  (duration: 331.776486ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:07:10.736571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.578637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-20T16:07:10.736612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:07:10.404438Z","time spent":"332.101794ms","remote":"127.0.0.1:38568","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:1060 > 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-20T16:07:10.736674Z","caller":"traceutil/trace.go:171","msg":"trace[1485303238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1067; }","duration":"332.69988ms","start":"2026-02-20T16:07:10.403948Z","end":"2026-02-20T16:07:10.736648Z","steps":["trace[1485303238] 'agreement among raft nodes before linearized reading'  (duration: 332.439183ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:07:10.736736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:07:10.403942Z","time spent":"332.778751ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-20T16:10:00.573387Z","caller":"traceutil/trace.go:171","msg":"trace[193734053] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"148.267287ms","start":"2026-02-20T16:10:00.425088Z","end":"2026-02-20T16:10:00.573356Z","steps":["trace[193734053] 'process raft request'  (duration: 147.894398ms)"],"step_count":1}