{"level":"warn","ts":"2026-02-20T15:45:24.148069Z","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-20T15:45:24.148151Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-20T15:45:24.148212Z","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-20T15:45:24.148223Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-02-20T15:45:24.148243Z","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-20T15:45:24.148776Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]}
{"level":"info","ts":"2026-02-20T15:45:24.148851Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-20T15:45:24.157065Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.029802ms"}
{"level":"info","ts":"2026-02-20T15:45:24.1631Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-02-20T15:45:24.163194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-02-20T15:45:24.163218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-02-20T15:45:24.163232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-20T15:45:24.163244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-02-20T15:45:24.163279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-02-20T15:45:24.170111Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-20T15:45:24.171277Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-20T15:45:24.172194Z","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-20T15:45:24.175174Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-20T15:45:24.175324Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-20T15:45:24.175509Z","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-20T15:45:24.175599Z","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-20T15:45:24.175609Z","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-20T15:45:24.177073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-02-20T15:45:24.177304Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-02-20T15:45:24.181062Z","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-20T15:45:24.181306Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-20T15:45:24.181338Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-20T15:45:24.182332Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-02-20T15:45:24.182354Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-02-20T15:45:24.464038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-02-20T15:45:24.464212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-20T15:45:24.464286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-02-20T15:45:24.46438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-02-20T15:45:24.464425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-02-20T15:45:24.464512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-02-20T15:45:24.464576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-02-20T15:45:24.466568Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:45:24.467298Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-20T15:45:24.467613Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-20T15:45:24.467834Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-20T15:45:24.467869Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-20T15:45:24.467747Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-20T15:45:24.471844Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-20T15:45:24.472657Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-02-20T15:45:24.472858Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:45:24.472974Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:45:24.473053Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:45:26.613039Z","caller":"traceutil/trace.go:171","msg":"trace[162018762] transaction","detail":"{read_only:false; response_revision:87; number_of_response:1; }","duration":"101.510135ms","start":"2026-02-20T15:45:26.511497Z","end":"2026-02-20T15:45:26.613007Z","steps":["trace[162018762] 'process raft request'  (duration: 52.667848ms)","trace[162018762] 'compare'  (duration: 48.702414ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:27.088574Z","caller":"traceutil/trace.go:171","msg":"trace[1986271762] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"121.919334ms","start":"2026-02-20T15:45:26.966631Z","end":"2026-02-20T15:45:27.08855Z","steps":["trace[1986271762] 'process raft request'  (duration: 114.734462ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:27.319841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.66741ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307194999823 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/priorityclasses/system-node-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-node-critical\" value_size:375 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-20T15:45:27.319975Z","caller":"traceutil/trace.go:171","msg":"trace[310296554] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"197.416939ms","start":"2026-02-20T15:45:27.12253Z","end":"2026-02-20T15:45:27.319947Z","steps":["trace[310296554] 'process raft request'  (duration: 67.175346ms)","trace[310296554] 'compare'  (duration: 129.501826ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:27.320058Z","caller":"traceutil/trace.go:171","msg":"trace[1890068529] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"135.529809ms","start":"2026-02-20T15:45:27.1845Z","end":"2026-02-20T15:45:27.32003Z","steps":["trace[1890068529] 'process raft request'  (duration: 135.459938ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:27.320281Z","caller":"traceutil/trace.go:171","msg":"trace[793798432] linearizableReadLoop","detail":"{readStateIndex:109; appliedIndex:107; }","duration":"196.019596ms","start":"2026-02-20T15:45:27.12424Z","end":"2026-02-20T15:45:27.320259Z","steps":["trace[793798432] 'read index received'  (duration: 57.056004ms)","trace[793798432] 'applied index is now lower than readState.Index'  (duration: 138.961092ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:27.320512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.241671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-20T15:45:27.320533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.944224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-20T15:45:27.320554Z","caller":"traceutil/trace.go:171","msg":"trace[1163929895] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:105; }","duration":"196.329453ms","start":"2026-02-20T15:45:27.124212Z","end":"2026-02-20T15:45:27.320541Z","steps":["trace[1163929895] 'agreement among raft nodes before linearized reading'  (duration: 196.180199ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:27.320575Z","caller":"traceutil/trace.go:171","msg":"trace[289118858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:105; }","duration":"109.034896ms","start":"2026-02-20T15:45:27.211529Z","end":"2026-02-20T15:45:27.320564Z","steps":["trace[289118858] 'agreement among raft nodes before linearized reading'  (duration: 108.951004ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:27.3206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.956536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-20T15:45:27.320651Z","caller":"traceutil/trace.go:171","msg":"trace[125507725] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:105; }","duration":"117.019398ms","start":"2026-02-20T15:45:27.203616Z","end":"2026-02-20T15:45:27.320635Z","steps":["trace[125507725] 'agreement among raft nodes before linearized reading'  (duration: 116.831663ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:27.698699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.152509ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307194999830 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-scheduler-instance.1895feed68b568eb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-scheduler-instance.1895feed68b568eb\" value_size:639 lease:7371157270340223936 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-20T15:45:27.69887Z","caller":"traceutil/trace.go:171","msg":"trace[29252130] linearizableReadLoop","detail":"{readStateIndex:113; appliedIndex:111; }","duration":"347.990213ms","start":"2026-02-20T15:45:27.350862Z","end":"2026-02-20T15:45:27.698852Z","steps":["trace[29252130] 'read index received'  (duration: 183.566437ms)","trace[29252130] 'applied index is now lower than readState.Index'  (duration: 164.422856ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:27.698976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.111036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-20T15:45:27.699008Z","caller":"traceutil/trace.go:171","msg":"trace[1454580201] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:108; }","duration":"348.160046ms","start":"2026-02-20T15:45:27.350839Z","end":"2026-02-20T15:45:27.698999Z","steps":["trace[1454580201] 'agreement among raft nodes before linearized reading'  (duration: 348.066124ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:27.699041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:27.350832Z","time spent":"348.201597ms","remote":"127.0.0.1:60544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "}
{"level":"info","ts":"2026-02-20T15:45:27.699221Z","caller":"traceutil/trace.go:171","msg":"trace[26124820] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"375.753067ms","start":"2026-02-20T15:45:27.323447Z","end":"2026-02-20T15:45:27.6992Z","steps":["trace[26124820] 'process raft request'  (duration: 211.030954ms)","trace[26124820] 'compare'  (duration: 164.020385ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:27.699407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:27.32342Z","time spent":"375.88535ms","remote":"127.0.0.1:60278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-scheduler-instance.1895feed68b568eb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-scheduler-instance.1895feed68b568eb\" value_size:639 lease:7371157270340223936 >> failure:<>"}
{"level":"info","ts":"2026-02-20T15:45:27.699255Z","caller":"traceutil/trace.go:171","msg":"trace[1768955520] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"374.452745ms","start":"2026-02-20T15:45:27.324767Z","end":"2026-02-20T15:45:27.69922Z","steps":["trace[1768955520] 'process raft request'  (duration: 374.030174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:27.699916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:27.324755Z","time spent":"375.082281ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/priorityclasses/system-cluster-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-cluster-critical\" value_size:407 >> failure:<>"}
{"level":"info","ts":"2026-02-20T15:45:27.88998Z","caller":"traceutil/trace.go:171","msg":"trace[1052091054] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"126.630025ms","start":"2026-02-20T15:45:27.763325Z","end":"2026-02-20T15:45:27.889955Z","steps":["trace[1052091054] 'process raft request'  (duration: 126.593454ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:27.890108Z","caller":"traceutil/trace.go:171","msg":"trace[897986112] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"134.729917ms","start":"2026-02-20T15:45:27.755321Z","end":"2026-02-20T15:45:27.890051Z","steps":["trace[897986112] 'process raft request'  (duration: 109.422506ms)","trace[897986112] 'compare'  (duration: 25.069115ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:28.107654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.087102ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307194999851 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:basic-user\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:basic-user\" value_size:617 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-20T15:45:28.107872Z","caller":"traceutil/trace.go:171","msg":"trace[1611990695] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"127.936888ms","start":"2026-02-20T15:45:27.979916Z","end":"2026-02-20T15:45:28.107853Z","steps":["trace[1611990695] 'process raft request'  (duration: 127.879137ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:28.107907Z","caller":"traceutil/trace.go:171","msg":"trace[1344809519] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"128.740028ms","start":"2026-02-20T15:45:27.979137Z","end":"2026-02-20T15:45:28.107877Z","steps":["trace[1344809519] 'process raft request'  (duration: 14.368538ms)","trace[1344809519] 'compare'  (duration: 113.97622ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:28.312157Z","caller":"traceutil/trace.go:171","msg":"trace[1967737626] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"114.014342ms","start":"2026-02-20T15:45:28.198119Z","end":"2026-02-20T15:45:28.312133Z","steps":["trace[1967737626] 'process raft request'  (duration: 19.060775ms)","trace[1967737626] 'compare'  (duration: 94.814043ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:28.58044Z","caller":"traceutil/trace.go:171","msg":"trace[2037120635] linearizableReadLoop","detail":"{readStateIndex:131; appliedIndex:130; }","duration":"168.368655ms","start":"2026-02-20T15:45:28.412044Z","end":"2026-02-20T15:45:28.580413Z","steps":["trace[2037120635] 'read index received'  (duration: 109.815076ms)","trace[2037120635] 'applied index is now lower than readState.Index'  (duration: 58.552579ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:28.580563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.498539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-20T15:45:28.580574Z","caller":"traceutil/trace.go:171","msg":"trace[233519296] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"216.368602ms","start":"2026-02-20T15:45:28.364191Z","end":"2026-02-20T15:45:28.580559Z","steps":["trace[233519296] 'process raft request'  (duration: 157.738991ms)","trace[233519296] 'compare'  (duration: 58.379315ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:28.580611Z","caller":"traceutil/trace.go:171","msg":"trace[1021308268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:126; }","duration":"168.572511ms","start":"2026-02-20T15:45:28.412021Z","end":"2026-02-20T15:45:28.580594Z","steps":["trace[1021308268] 'agreement among raft nodes before linearized reading'  (duration: 168.482489ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:28.834784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.933788ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307194999873 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:heapster\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:heapster\" value_size:579 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:45:28.834965Z","caller":"traceutil/trace.go:171","msg":"trace[2145961005] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"162.135781ms","start":"2026-02-20T15:45:28.672769Z","end":"2026-02-20T15:45:28.834905Z","steps":["trace[2145961005] 'process raft request'  (duration: 27.995358ms)","trace[2145961005] 'compare'  (duration: 133.758353ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:29.024573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.803828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:45:29.024657Z","caller":"traceutil/trace.go:171","msg":"trace[235452517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:131; }","duration":"160.916531ms","start":"2026-02-20T15:45:28.863717Z","end":"2026-02-20T15:45:29.024634Z","steps":["trace[235452517] 'agreement among raft nodes before linearized reading'  (duration: 71.492962ms)","trace[235452517] 'range keys from in-memory index tree'  (duration: 89.314516ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:29.356723Z","caller":"traceutil/trace.go:171","msg":"trace[2059689237] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"122.523034ms","start":"2026-02-20T15:45:29.234165Z","end":"2026-02-20T15:45:29.356688Z","steps":["trace[2059689237] 'process raft request'  (duration: 53.439932ms)","trace[2059689237] 'compare'  (duration: 68.956208ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:45:52.640565Z","caller":"traceutil/trace.go:171","msg":"trace[257441072] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"115.007076ms","start":"2026-02-20T15:45:52.525532Z","end":"2026-02-20T15:45:52.640539Z","steps":["trace[257441072] 'read index received'  (duration: 114.699168ms)","trace[257441072] 'applied index is now lower than readState.Index'  (duration: 306.618µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:52.640697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.15281ms","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-20T15:45:52.640674Z","caller":"traceutil/trace.go:171","msg":"trace[1428247835] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"305.957954ms","start":"2026-02-20T15:45:52.334684Z","end":"2026-02-20T15:45:52.640642Z","steps":["trace[1428247835] 'process raft request'  (duration: 305.652107ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:52.640739Z","caller":"traceutil/trace.go:171","msg":"trace[331134447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:464; }","duration":"115.252512ms","start":"2026-02-20T15:45:52.525474Z","end":"2026-02-20T15:45:52.640727Z","steps":["trace[331134447] 'agreement among raft nodes before linearized reading'  (duration: 115.16166ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:52.641057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:52.334662Z","time spent":"306.107659ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:459 > 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-20T15:45:57.246094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.098209ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195000668 > lease_revoke:<id:664b9c7bba2ac69d>","response":"size:29"}
{"level":"info","ts":"2026-02-20T15:45:57.246252Z","caller":"traceutil/trace.go:171","msg":"trace[1317401859] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"743.929248ms","start":"2026-02-20T15:45:56.502298Z","end":"2026-02-20T15:45:57.246227Z","steps":["trace[1317401859] 'read index received'  (duration: 35.731µs)","trace[1317401859] 'applied index is now lower than readState.Index'  (duration: 743.891977ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:57.246386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.085382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:45:57.246348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.570724ms","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-20T15:45:57.246514Z","caller":"traceutil/trace.go:171","msg":"trace[1239476856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"744.234996ms","start":"2026-02-20T15:45:56.502247Z","end":"2026-02-20T15:45:57.246482Z","steps":["trace[1239476856] 'agreement among raft nodes before linearized reading'  (duration: 744.073062ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.246572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:56.502227Z","time spent":"744.332009ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-20T15:45:57.246593Z","caller":"traceutil/trace.go:171","msg":"trace[350428498] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:506; }","duration":"876.851451ms","start":"2026-02-20T15:45:56.369693Z","end":"2026-02-20T15:45:57.246544Z","steps":["trace[350428498] 'range keys from in-memory index tree'  (duration: 876.539434ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:57.376113Z","caller":"traceutil/trace.go:171","msg":"trace[1660935579] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"129.801274ms","start":"2026-02-20T15:45:57.246284Z","end":"2026-02-20T15:45:57.376085Z","steps":["trace[1660935579] 'read index received'  (duration: 129.64417ms)","trace[1660935579] 'applied index is now lower than readState.Index'  (duration: 155.964µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:57.376335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.779422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4020"}
{"level":"warn","ts":"2026-02-20T15:45:57.37633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.016637ms","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-20T15:45:57.37635Z","caller":"traceutil/trace.go:171","msg":"trace[73403742] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"299.131975ms","start":"2026-02-20T15:45:57.077193Z","end":"2026-02-20T15:45:57.376325Z","steps":["trace[73403742] 'process raft request'  (duration: 298.698054ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:57.376412Z","caller":"traceutil/trace.go:171","msg":"trace[1512079904] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"347.11925ms","start":"2026-02-20T15:45:57.029274Z","end":"2026-02-20T15:45:57.376393Z","steps":["trace[1512079904] 'agreement among raft nodes before linearized reading'  (duration: 346.899854ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.376452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:57.02917Z","time spent":"347.272884ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T15:45:57.376442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.646896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:45:57.376476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.941947ms","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-20T15:45:57.376377Z","caller":"traceutil/trace.go:171","msg":"trace[225111847] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:507; }","duration":"474.867834ms","start":"2026-02-20T15:45:56.901499Z","end":"2026-02-20T15:45:57.376367Z","steps":["trace[225111847] 'agreement among raft nodes before linearized reading'  (duration: 474.72157ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:57.376522Z","caller":"traceutil/trace.go:171","msg":"trace[1456959221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:507; }","duration":"703.04983ms","start":"2026-02-20T15:45:56.673458Z","end":"2026-02-20T15:45:57.376508Z","steps":["trace[1456959221] 'agreement among raft nodes before linearized reading'  (duration: 702.804984ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.37653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:56.901482Z","time spent":"475.038968ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4044,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-20T15:45:57.376555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:56.67342Z","time spent":"703.128832ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-20T15:45:57.376581Z","caller":"traceutil/trace.go:171","msg":"trace[1381314910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"128.746949ms","start":"2026-02-20T15:45:57.247758Z","end":"2026-02-20T15:45:57.376505Z","steps":["trace[1381314910] 'agreement among raft nodes before linearized reading'  (duration: 128.586785ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.376589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.686569ms","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-20T15:45:57.37672Z","caller":"traceutil/trace.go:171","msg":"trace[973979063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"645.822844ms","start":"2026-02-20T15:45:56.730843Z","end":"2026-02-20T15:45:57.376665Z","steps":["trace[973979063] 'agreement among raft nodes before linearized reading'  (duration: 645.453204ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.376822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:56.730816Z","time spent":"645.991237ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-20T15:45:57.880128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.417842ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195000673 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:497 > 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-20T15:45:57.880683Z","caller":"traceutil/trace.go:171","msg":"trace[240789445] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"498.084032ms","start":"2026-02-20T15:45:57.382246Z","end":"2026-02-20T15:45:57.88033Z","steps":["trace[240789445] 'process raft request'  (duration: 334.353882ms)","trace[240789445] 'compare'  (duration: 163.162986ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:45:57.88092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:57.382223Z","time spent":"498.606126ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:497 > 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-20T15:45:57.897609Z","caller":"traceutil/trace.go:171","msg":"trace[1531503922] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"515.135177ms","start":"2026-02-20T15:45:57.38245Z","end":"2026-02-20T15:45:57.897585Z","steps":["trace[1531503922] 'process raft request'  (duration: 515.043825ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:45:57.897741Z","caller":"traceutil/trace.go:171","msg":"trace[117449820] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"515.377713ms","start":"2026-02-20T15:45:57.382286Z","end":"2026-02-20T15:45:57.897664Z","steps":["trace[117449820] 'process raft request'  (duration: 515.076656ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.8979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:57.382271Z","time spent":"515.591849ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:506 > 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-20T15:45:57.897944Z","caller":"traceutil/trace.go:171","msg":"trace[24527889] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"512.746688ms","start":"2026-02-20T15:45:57.385171Z","end":"2026-02-20T15:45:57.897918Z","steps":["trace[24527889] 'process raft request'  (duration: 512.658176ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.897754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:57.38237Z","time spent":"515.312902ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:502 > 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-20T15:45:57.898117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:57.385158Z","time spent":"512.850661ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:411 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4178 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-20T15:45:57.898098Z","caller":"traceutil/trace.go:171","msg":"trace[1498850809] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"515.470386ms","start":"2026-02-20T15:45:57.382582Z","end":"2026-02-20T15:45:57.898052Z","steps":["trace[1498850809] 'process raft request'  (duration: 514.965303ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:45:57.8986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:45:57.38257Z","time spent":"515.786323ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:503 > 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-20T15:46:04.101614Z","caller":"traceutil/trace.go:171","msg":"trace[334624818] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:546; }","duration":"201.542871ms","start":"2026-02-20T15:46:03.900048Z","end":"2026-02-20T15:46:04.101591Z","steps":["trace[334624818] 'read index received'  (duration: 201.296715ms)","trace[334624818] 'applied index is now lower than readState.Index'  (duration: 245.086µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:04.10168Z","caller":"traceutil/trace.go:171","msg":"trace[1781464489] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"459.482759ms","start":"2026-02-20T15:46:03.642164Z","end":"2026-02-20T15:46:04.101647Z","steps":["trace[1781464489] 'process raft request'  (duration: 459.260004ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.101876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.808887ms","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-20T15:46:04.102343Z","caller":"traceutil/trace.go:171","msg":"trace[2108810755] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:526; }","duration":"202.326891ms","start":"2026-02-20T15:46:03.899994Z","end":"2026-02-20T15:46:04.102321Z","steps":["trace[2108810755] 'agreement among raft nodes before linearized reading'  (duration: 201.697456ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.101948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.078632ms","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-20T15:46:04.102454Z","caller":"traceutil/trace.go:171","msg":"trace[1757481887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:526; }","duration":"179.699248ms","start":"2026-02-20T15:46:03.922737Z","end":"2026-02-20T15:46:04.102436Z","steps":["trace[1757481887] 'agreement among raft nodes before linearized reading'  (duration: 179.147194ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.101976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.374868ms","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-20T15:46:04.102672Z","caller":"traceutil/trace.go:171","msg":"trace[270430539] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:526; }","duration":"186.048285ms","start":"2026-02-20T15:46:03.916563Z","end":"2026-02-20T15:46:04.102611Z","steps":["trace[270430539] 'agreement among raft nodes before linearized reading'  (duration: 185.300757ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.101998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.96228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-20T15:46:04.102891Z","caller":"traceutil/trace.go:171","msg":"trace[1755509194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"175.875303ms","start":"2026-02-20T15:46:03.926986Z","end":"2026-02-20T15:46:04.102861Z","steps":["trace[1755509194] 'agreement among raft nodes before linearized reading'  (duration: 174.902978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.102248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:03.642151Z","time spent":"459.981272ms","remote":"127.0.0.1:60380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-q4zjp\" mod_revision:500 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-q4zjp\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-q4zjp\" > >"}
{"level":"info","ts":"2026-02-20T15:46:04.634927Z","caller":"traceutil/trace.go:171","msg":"trace[1050899805] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"528.259355ms","start":"2026-02-20T15:46:04.106646Z","end":"2026-02-20T15:46:04.634905Z","steps":["trace[1050899805] 'process raft request'  (duration: 528.120321ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.635089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:04.106619Z","time spent":"528.395598ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:518 > 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-20T15:46:04.657077Z","caller":"traceutil/trace.go:171","msg":"trace[1577955951] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"549.686549ms","start":"2026-02-20T15:46:04.107373Z","end":"2026-02-20T15:46:04.65706Z","steps":["trace[1577955951] 'process raft request'  (duration: 549.549245ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.657196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:04.107366Z","time spent":"549.764621ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:521 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-20T15:46:04.657386Z","caller":"traceutil/trace.go:171","msg":"trace[951779003] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"549.559865ms","start":"2026-02-20T15:46:04.107804Z","end":"2026-02-20T15:46:04.657364Z","steps":["trace[951779003] 'process raft request'  (duration: 549.221707ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:04.6574Z","caller":"traceutil/trace.go:171","msg":"trace[361270533] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"549.293609ms","start":"2026-02-20T15:46:04.108084Z","end":"2026-02-20T15:46:04.657378Z","steps":["trace[361270533] 'process raft request'  (duration: 549.201877ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:04.657603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:04.108075Z","time spent":"549.423242ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:519 > 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-20T15:46:04.657673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:04.107781Z","time spent":"549.658288ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:520 > 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-20T15:46:06.61781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.109337ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195000726 > lease_revoke:<id:664b9c7bba2ac702>","response":"size:29"}
{"level":"info","ts":"2026-02-20T15:46:06.617908Z","caller":"traceutil/trace.go:171","msg":"trace[1246186483] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"116.779931ms","start":"2026-02-20T15:46:06.501111Z","end":"2026-02-20T15:46:06.617891Z","steps":["trace[1246186483] 'read index received'  (duration: 41.211µs)","trace[1246186483] 'applied index is now lower than readState.Index'  (duration: 116.73714ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:46:06.617981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.867703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:46:06.618006Z","caller":"traceutil/trace.go:171","msg":"trace[244993411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"116.938914ms","start":"2026-02-20T15:46:06.501058Z","end":"2026-02-20T15:46:06.617997Z","steps":["trace[244993411] 'agreement among raft nodes before linearized reading'  (duration: 116.879073ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:08.939333Z","caller":"traceutil/trace.go:171","msg":"trace[1053827896] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"103.55473ms","start":"2026-02-20T15:46:08.835752Z","end":"2026-02-20T15:46:08.939306Z","steps":["trace[1053827896] 'process raft request'  (duration: 103.421007ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:09.887291Z","caller":"traceutil/trace.go:171","msg":"trace[554024778] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"102.243768ms","start":"2026-02-20T15:46:09.78503Z","end":"2026-02-20T15:46:09.887274Z","steps":["trace[554024778] 'process raft request'  (duration: 102.132176ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:09.965845Z","caller":"traceutil/trace.go:171","msg":"trace[1421395068] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"126.39574ms","start":"2026-02-20T15:46:09.839424Z","end":"2026-02-20T15:46:09.96582Z","steps":["trace[1421395068] 'process raft request'  (duration: 126.239436ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:11.946814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.852277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-02-20T15:46:11.946926Z","caller":"traceutil/trace.go:171","msg":"trace[438389675] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:602; }","duration":"112.034982ms","start":"2026-02-20T15:46:11.834871Z","end":"2026-02-20T15:46:11.946906Z","steps":["trace[438389675] 'range keys from in-memory index tree'  (duration: 111.596021ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:20.090207Z","caller":"traceutil/trace.go:171","msg":"trace[1631580261] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"356.690499ms","start":"2026-02-20T15:46:19.733489Z","end":"2026-02-20T15:46:20.09018Z","steps":["trace[1631580261] 'process raft request'  (duration: 356.515274ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:20.090367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:19.733467Z","time spent":"356.817951ms","remote":"127.0.0.1:60380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4832,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-77cccfdc44-m7c94\" mod_revision:682 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-77cccfdc44-m7c94\" value_size:4773 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-77cccfdc44-m7c94\" > >"}
{"level":"warn","ts":"2026-02-20T15:46:27.776947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.820105918s","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001080 > lease_revoke:<id:664b9c7bba2ac7fd>","response":"size:29"}
{"level":"info","ts":"2026-02-20T15:46:27.777071Z","caller":"traceutil/trace.go:171","msg":"trace[1129104674] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"1.274895092s","start":"2026-02-20T15:46:26.502159Z","end":"2026-02-20T15:46:27.777054Z","steps":["trace[1129104674] 'read index received'  (duration: 54.242µs)","trace[1129104674] 'applied index is now lower than readState.Index'  (duration: 1.274839299s)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:46:27.777238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275078026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:46:27.777234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407197657s","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-20T15:46:27.777339Z","caller":"traceutil/trace.go:171","msg":"trace[120488876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:721; }","duration":"1.275157248s","start":"2026-02-20T15:46:26.502107Z","end":"2026-02-20T15:46:27.777264Z","steps":["trace[120488876] 'agreement among raft nodes before linearized reading'  (duration: 1.275085636s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:27.777347Z","caller":"traceutil/trace.go:171","msg":"trace[572994450] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:721; }","duration":"1.40731296s","start":"2026-02-20T15:46:26.370012Z","end":"2026-02-20T15:46:27.777325Z","steps":["trace[572994450] 'range keys from in-memory index tree'  (duration: 1.407182837s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.777383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:26.502058Z","time spent":"1.275316932s","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T15:46:27.777464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248561044s","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-20T15:46:27.777503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:27.311737Z","time spent":"465.763617ms","remote":"127.0.0.1:60278","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-20T15:46:27.777534Z","caller":"traceutil/trace.go:171","msg":"trace[1211656060] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:721; }","duration":"1.248678287s","start":"2026-02-20T15:46:26.528843Z","end":"2026-02-20T15:46:27.777521Z","steps":["trace[1211656060] 'agreement among raft nodes before linearized reading'  (duration: 1.248510713s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.777544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.413338ms","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":"warn","ts":"2026-02-20T15:46:27.777564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:26.528821Z","time spent":"1.248738019s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-20T15:46:27.777575Z","caller":"traceutil/trace.go:171","msg":"trace[211854180] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:721; }","duration":"101.480719ms","start":"2026-02-20T15:46:27.67608Z","end":"2026-02-20T15:46:27.777561Z","steps":["trace[211854180] 'agreement among raft nodes before linearized reading'  (duration: 101.418808ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.777465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.2428ms","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-20T15:46:27.777753Z","caller":"traceutil/trace.go:171","msg":"trace[269646872] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:721; }","duration":"956.545988ms","start":"2026-02-20T15:46:26.821192Z","end":"2026-02-20T15:46:27.777738Z","steps":["trace[269646872] 'agreement among raft nodes before linearized reading'  (duration: 956.189189ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.777768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.124859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-20T15:46:27.777793Z","caller":"traceutil/trace.go:171","msg":"trace[1648800707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:721; }","duration":"987.172441ms","start":"2026-02-20T15:46:26.790613Z","end":"2026-02-20T15:46:27.777786Z","steps":["trace[1648800707] 'agreement among raft nodes before linearized reading'  (duration: 987.111579ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.77779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:26.821186Z","time spent":"956.593699ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T15:46:27.77781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:26.7906Z","time spent":"987.206261ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T15:46:27.777723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.24526ms","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-20T15:46:27.777819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.905896ms","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-20T15:46:27.777838Z","caller":"traceutil/trace.go:171","msg":"trace[1480594684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:721; }","duration":"960.960268ms","start":"2026-02-20T15:46:26.816872Z","end":"2026-02-20T15:46:27.777832Z","steps":["trace[1480594684] 'agreement among raft nodes before linearized reading'  (duration: 960.909687ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:27.777841Z","caller":"traceutil/trace.go:171","msg":"trace[2119805466] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:721; }","duration":"958.359413ms","start":"2026-02-20T15:46:26.819471Z","end":"2026-02-20T15:46:27.777831Z","steps":["trace[2119805466] 'agreement among raft nodes before linearized reading'  (duration: 958.211319ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.777855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:26.816851Z","time spent":"961.000998ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-20T15:46:27.777874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:26.81942Z","time spent":"958.443105ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-20T15:46:27.968867Z","caller":"traceutil/trace.go:171","msg":"trace[1533015586] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"187.059042ms","start":"2026-02-20T15:46:27.781782Z","end":"2026-02-20T15:46:27.968841Z","steps":["trace[1533015586] 'process raft request'  (duration: 186.97323ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:27.968899Z","caller":"traceutil/trace.go:171","msg":"trace[141049750] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"187.314698ms","start":"2026-02-20T15:46:27.781549Z","end":"2026-02-20T15:46:27.968864Z","steps":["trace[141049750] 'process raft request'  (duration: 96.836273ms)","trace[141049750] 'compare'  (duration: 90.215158ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:27.969216Z","caller":"traceutil/trace.go:171","msg":"trace[1185454172] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"187.364589ms","start":"2026-02-20T15:46:27.781833Z","end":"2026-02-20T15:46:27.969198Z","steps":["trace[1185454172] 'process raft request'  (duration: 186.968479ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:27.969224Z","caller":"traceutil/trace.go:171","msg":"trace[1951586456] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:749; }","duration":"183.40741ms","start":"2026-02-20T15:46:27.785793Z","end":"2026-02-20T15:46:27.969201Z","steps":["trace[1951586456] 'read index received'  (duration: 85.270285ms)","trace[1951586456] 'applied index is now lower than readState.Index'  (duration: 98.136145ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:27.969336Z","caller":"traceutil/trace.go:171","msg":"trace[793397036] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"185.914053ms","start":"2026-02-20T15:46:27.783401Z","end":"2026-02-20T15:46:27.969315Z","steps":["trace[793397036] 'process raft request'  (duration: 185.746169ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:27.969318Z","caller":"traceutil/trace.go:171","msg":"trace[2126665707] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"187.296238ms","start":"2026-02-20T15:46:27.781979Z","end":"2026-02-20T15:46:27.969275Z","steps":["trace[2126665707] 'process raft request'  (duration: 187.036302ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:27.969363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.549624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:46:27.969401Z","caller":"traceutil/trace.go:171","msg":"trace[1496731754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"183.603655ms","start":"2026-02-20T15:46:27.785788Z","end":"2026-02-20T15:46:27.969391Z","steps":["trace[1496731754] 'agreement among raft nodes before linearized reading'  (duration: 183.496852ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:28.305107Z","caller":"traceutil/trace.go:171","msg":"trace[1979425871] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"171.426121ms","start":"2026-02-20T15:46:28.133663Z","end":"2026-02-20T15:46:28.305089Z","steps":["trace[1979425871] 'process raft request'  (duration: 171.306168ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:30.884599Z","caller":"traceutil/trace.go:171","msg":"trace[1919927880] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"114.638617ms","start":"2026-02-20T15:46:30.769942Z","end":"2026-02-20T15:46:30.88458Z","steps":["trace[1919927880] 'process raft request'  (duration: 114.485343ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:34.239172Z","caller":"traceutil/trace.go:171","msg":"trace[1568610875] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"155.78805ms","start":"2026-02-20T15:46:34.083361Z","end":"2026-02-20T15:46:34.239149Z","steps":["trace[1568610875] 'process raft request'  (duration: 124.55793ms)","trace[1568610875] 'compare'  (duration: 31.133488ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:50.247835Z","caller":"traceutil/trace.go:171","msg":"trace[418480111] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"115.741171ms","start":"2026-02-20T15:46:50.132073Z","end":"2026-02-20T15:46:50.247814Z","steps":["trace[418480111] 'read index received'  (duration: 115.611638ms)","trace[418480111] 'applied index is now lower than readState.Index'  (duration: 128.473µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:50.248054Z","caller":"traceutil/trace.go:171","msg":"trace[2097825393] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"119.122069ms","start":"2026-02-20T15:46:50.128901Z","end":"2026-02-20T15:46:50.248023Z","steps":["trace[2097825393] 'process raft request'  (duration: 118.76863ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:50.248071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.985708ms","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-20T15:46:50.248751Z","caller":"traceutil/trace.go:171","msg":"trace[868480141] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"116.684286ms","start":"2026-02-20T15:46:50.132022Z","end":"2026-02-20T15:46:50.248706Z","steps":["trace[868480141] 'agreement among raft nodes before linearized reading'  (duration: 115.928827ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:51.072818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:50.719751Z","time spent":"353.062876ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-20T15:46:51.936282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.635386ms","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-20T15:46:51.93638Z","caller":"traceutil/trace.go:171","msg":"trace[1254637783] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:796; }","duration":"750.794181ms","start":"2026-02-20T15:46:51.185564Z","end":"2026-02-20T15:46:51.936358Z","steps":["trace[1254637783] 'count revisions from in-memory index tree'  (duration: 750.558255ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:51.936434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:46:51.18555Z","time spent":"750.867882ms","remote":"127.0.0.1:60716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":99,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-02-20T15:46:52.363742Z","caller":"traceutil/trace.go:171","msg":"trace[52267420] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"108.193256ms","start":"2026-02-20T15:46:52.255528Z","end":"2026-02-20T15:46:52.363721Z","steps":["trace[52267420] 'process raft request'  (duration: 108.035952ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:52.523901Z","caller":"traceutil/trace.go:171","msg":"trace[2026303278] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"106.192833ms","start":"2026-02-20T15:46:52.417679Z","end":"2026-02-20T15:46:52.523872Z","steps":["trace[2026303278] 'process raft request'  (duration: 26.750283ms)","trace[2026303278] 'compare'  (duration: 79.145723ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:54.598894Z","caller":"traceutil/trace.go:171","msg":"trace[1838768377] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"215.987501ms","start":"2026-02-20T15:46:54.38288Z","end":"2026-02-20T15:46:54.598868Z","steps":["trace[1838768377] 'read index received'  (duration: 215.885189ms)","trace[1838768377] 'applied index is now lower than readState.Index'  (duration: 101.202µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:54.5994Z","caller":"traceutil/trace.go:171","msg":"trace[2097367168] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"225.918748ms","start":"2026-02-20T15:46:54.373452Z","end":"2026-02-20T15:46:54.599371Z","steps":["trace[2097367168] 'process raft request'  (duration: 225.255131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:54.599458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.556526ms","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-20T15:46:54.599516Z","caller":"traceutil/trace.go:171","msg":"trace[1042248704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"216.660409ms","start":"2026-02-20T15:46:54.382835Z","end":"2026-02-20T15:46:54.599495Z","steps":["trace[1042248704] 'agreement among raft nodes before linearized reading'  (duration: 216.436563ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:54.599827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.978919ms","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-20T15:46:54.600002Z","caller":"traceutil/trace.go:171","msg":"trace[1920315661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:803; }","duration":"182.182544ms","start":"2026-02-20T15:46:54.417798Z","end":"2026-02-20T15:46:54.599981Z","steps":["trace[1920315661] 'agreement among raft nodes before linearized reading'  (duration: 181.852626ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:54.600274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.635606ms","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-20T15:46:54.60033Z","caller":"traceutil/trace.go:171","msg":"trace[1947380990] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"182.719869ms","start":"2026-02-20T15:46:54.417597Z","end":"2026-02-20T15:46:54.600317Z","steps":["trace[1947380990] 'agreement among raft nodes before linearized reading'  (duration: 181.660181ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:46:58.761466Z","caller":"traceutil/trace.go:171","msg":"trace[1424752706] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:848; }","duration":"123.186295ms","start":"2026-02-20T15:46:58.638252Z","end":"2026-02-20T15:46:58.761439Z","steps":["trace[1424752706] 'read index received'  (duration: 14.912377ms)","trace[1424752706] 'applied index is now lower than readState.Index'  (duration: 108.272668ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:46:58.761548Z","caller":"traceutil/trace.go:171","msg":"trace[1717406474] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"130.792922ms","start":"2026-02-20T15:46:58.630714Z","end":"2026-02-20T15:46:58.761506Z","steps":["trace[1717406474] 'process raft request'  (duration: 126.49886ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:58.761747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.799934ms","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-20T15:46:58.761796Z","caller":"traceutil/trace.go:171","msg":"trace[4520841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"122.917388ms","start":"2026-02-20T15:46:58.638868Z","end":"2026-02-20T15:46:58.761785Z","steps":["trace[4520841] 'agreement among raft nodes before linearized reading'  (duration: 122.742963ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:58.761898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.955829ms","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-20T15:46:58.761979Z","caller":"traceutil/trace.go:171","msg":"trace[1885135226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"113.070471ms","start":"2026-02-20T15:46:58.64889Z","end":"2026-02-20T15:46:58.761961Z","steps":["trace[1885135226] 'agreement among raft nodes before linearized reading'  (duration: 112.796634ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:46:58.761956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.608415ms","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-20T15:46:58.76262Z","caller":"traceutil/trace.go:171","msg":"trace[215589841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"124.399266ms","start":"2026-02-20T15:46:58.638191Z","end":"2026-02-20T15:46:58.76259Z","steps":["trace[215589841] 'agreement among raft nodes before linearized reading'  (duration: 123.41043ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:00.84132Z","caller":"traceutil/trace.go:171","msg":"trace[606461745] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"100.682931ms","start":"2026-02-20T15:47:00.740593Z","end":"2026-02-20T15:47:00.841276Z","steps":["trace[606461745] 'process raft request'  (duration: 84.389079ms)","trace[606461745] 'compare'  (duration: 16.025465ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:00.976716Z","caller":"traceutil/trace.go:171","msg":"trace[986648552] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:856; }","duration":"128.230866ms","start":"2026-02-20T15:47:00.848455Z","end":"2026-02-20T15:47:00.976686Z","steps":["trace[986648552] 'read index received'  (duration: 109.148891ms)","trace[986648552] 'applied index is now lower than readState.Index'  (duration: 19.080615ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:00.976811Z","caller":"traceutil/trace.go:171","msg":"trace[857671663] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"129.710114ms","start":"2026-02-20T15:47:00.847069Z","end":"2026-02-20T15:47:00.976779Z","steps":["trace[857671663] 'process raft request'  (duration: 129.486958ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:00.976889Z","caller":"traceutil/trace.go:171","msg":"trace[901015409] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"129.889299ms","start":"2026-02-20T15:47:00.846983Z","end":"2026-02-20T15:47:00.976872Z","steps":["trace[901015409] 'process raft request'  (duration: 110.452934ms)","trace[901015409] 'compare'  (duration: 18.996373ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:00.976884Z","caller":"traceutil/trace.go:171","msg":"trace[2078675033] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"129.736814ms","start":"2026-02-20T15:47:00.847117Z","end":"2026-02-20T15:47:00.976854Z","steps":["trace[2078675033] 'process raft request'  (duration: 129.486308ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:00.977084Z","caller":"traceutil/trace.go:171","msg":"trace[1286477286] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"129.432596ms","start":"2026-02-20T15:47:00.847621Z","end":"2026-02-20T15:47:00.977054Z","steps":["trace[1286477286] 'process raft request'  (duration: 129.030136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:00.977181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.700038ms","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-20T15:47:00.977221Z","caller":"traceutil/trace.go:171","msg":"trace[344516228] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:824; }","duration":"128.79244ms","start":"2026-02-20T15:47:00.848416Z","end":"2026-02-20T15:47:00.977208Z","steps":["trace[344516228] 'agreement among raft nodes before linearized reading'  (duration: 128.629546ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:05.197808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.117466ms","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-20T15:47:05.197916Z","caller":"traceutil/trace.go:171","msg":"trace[841579474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:832; }","duration":"132.25474ms","start":"2026-02-20T15:47:05.065631Z","end":"2026-02-20T15:47:05.197885Z","steps":["trace[841579474] 'range keys from in-memory index tree'  (duration: 131.610223ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:05.198234Z","caller":"traceutil/trace.go:171","msg":"trace[1081563767] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"128.700097ms","start":"2026-02-20T15:47:05.069519Z","end":"2026-02-20T15:47:05.198219Z","steps":["trace[1081563767] 'process raft request'  (duration: 128.607455ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:05.198284Z","caller":"traceutil/trace.go:171","msg":"trace[317902247] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"128.757289ms","start":"2026-02-20T15:47:05.069493Z","end":"2026-02-20T15:47:05.19825Z","steps":["trace[317902247] 'process raft request'  (duration: 128.447931ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:14.734942Z","caller":"traceutil/trace.go:171","msg":"trace[989619358] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:947; }","duration":"232.812487ms","start":"2026-02-20T15:47:14.502106Z","end":"2026-02-20T15:47:14.734918Z","steps":["trace[989619358] 'read index received'  (duration: 232.602532ms)","trace[989619358] 'applied index is now lower than readState.Index'  (duration: 209.145µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:14.735083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.959811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:14.735077Z","caller":"traceutil/trace.go:171","msg":"trace[335984944] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"473.90581ms","start":"2026-02-20T15:47:14.261139Z","end":"2026-02-20T15:47:14.735045Z","steps":["trace[335984944] 'process raft request'  (duration: 473.639973ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:14.735117Z","caller":"traceutil/trace.go:171","msg":"trace[1478253355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:909; }","duration":"233.071414ms","start":"2026-02-20T15:47:14.502035Z","end":"2026-02-20T15:47:14.735106Z","steps":["trace[1478253355] 'agreement among raft nodes before linearized reading'  (duration: 233.002632ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:14.735243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:14.261113Z","time spent":"474.046854ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:830 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-20T15:47:15.609162Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529307195001565,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T15:47:15.632924Z","caller":"traceutil/trace.go:171","msg":"trace[1139658724] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:948; }","duration":"524.259195ms","start":"2026-02-20T15:47:15.108648Z","end":"2026-02-20T15:47:15.632907Z","steps":["trace[1139658724] 'read index received'  (duration: 524.126801ms)","trace[1139658724] 'applied index is now lower than readState.Index'  (duration: 132.004µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:15.633133Z","caller":"traceutil/trace.go:171","msg":"trace[2122827034] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"764.250698ms","start":"2026-02-20T15:47:14.868876Z","end":"2026-02-20T15:47:15.633126Z","steps":["trace[2122827034] 'process raft request'  (duration: 763.94151ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:15.633203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:14.86885Z","time spent":"764.297779ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:904 > 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-20T15:47:15.63335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.716696ms","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-20T15:47:15.633367Z","caller":"traceutil/trace.go:171","msg":"trace[754264838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:910; }","duration":"524.765228ms","start":"2026-02-20T15:47:15.108596Z","end":"2026-02-20T15:47:15.633361Z","steps":["trace[754264838] 'agreement among raft nodes before linearized reading'  (duration: 524.697206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:15.633383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:15.108573Z","time spent":"524.807939ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T15:47:15.633464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.030301ms","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-20T15:47:15.633476Z","caller":"traceutil/trace.go:171","msg":"trace[1948479839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:910; }","duration":"366.064882ms","start":"2026-02-20T15:47:15.267407Z","end":"2026-02-20T15:47:15.633472Z","steps":["trace[1948479839] 'agreement among raft nodes before linearized reading'  (duration: 366.030381ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:15.633487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:15.267388Z","time spent":"366.096753ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-20T15:47:15.633616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.562414ms","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-20T15:47:15.633632Z","caller":"traceutil/trace.go:171","msg":"trace[364797660] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:910; }","duration":"236.586864ms","start":"2026-02-20T15:47:15.397041Z","end":"2026-02-20T15:47:15.633628Z","steps":["trace[364797660] 'agreement among raft nodes before linearized reading'  (duration: 236.545533ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:15.63372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.694237ms","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-20T15:47:15.633732Z","caller":"traceutil/trace.go:171","msg":"trace[622052985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:910; }","duration":"236.732438ms","start":"2026-02-20T15:47:15.396996Z","end":"2026-02-20T15:47:15.633728Z","steps":["trace[622052985] 'agreement among raft nodes before linearized reading'  (duration: 236.694807ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:23.851794Z","caller":"traceutil/trace.go:171","msg":"trace[1337510513] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:972; }","duration":"125.528175ms","start":"2026-02-20T15:47:23.726246Z","end":"2026-02-20T15:47:23.851774Z","steps":["trace[1337510513] 'read index received'  (duration: 125.424793ms)","trace[1337510513] 'applied index is now lower than readState.Index'  (duration: 102.462µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:23.851921Z","caller":"traceutil/trace.go:171","msg":"trace[1428432783] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"127.460755ms","start":"2026-02-20T15:47:23.724427Z","end":"2026-02-20T15:47:23.851888Z","steps":["trace[1428432783] 'process raft request'  (duration: 127.214829ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:23.852002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.745591ms","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-20T15:47:23.852031Z","caller":"traceutil/trace.go:171","msg":"trace[1709374224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:932; }","duration":"125.841114ms","start":"2026-02-20T15:47:23.72618Z","end":"2026-02-20T15:47:23.852021Z","steps":["trace[1709374224] 'agreement among raft nodes before linearized reading'  (duration: 125.721801ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:23.852189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.122719ms","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-20T15:47:23.852207Z","caller":"traceutil/trace.go:171","msg":"trace[1023709164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:932; }","duration":"124.152459ms","start":"2026-02-20T15:47:23.728049Z","end":"2026-02-20T15:47:23.852201Z","steps":["trace[1023709164] 'agreement among raft nodes before linearized reading'  (duration: 124.097548ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:23.852238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.211331ms","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-20T15:47:23.852276Z","caller":"traceutil/trace.go:171","msg":"trace[1174271569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:932; }","duration":"124.279353ms","start":"2026-02-20T15:47:23.727985Z","end":"2026-02-20T15:47:23.852264Z","steps":["trace[1174271569] 'agreement among raft nodes before linearized reading'  (duration: 124.112399ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:23.852411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.359475ms","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-20T15:47:23.852517Z","caller":"traceutil/trace.go:171","msg":"trace[1688878614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:932; }","duration":"124.478128ms","start":"2026-02-20T15:47:23.728005Z","end":"2026-02-20T15:47:23.852483Z","steps":["trace[1688878614] 'agreement among raft nodes before linearized reading'  (duration: 124.270262ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:28.21388Z","caller":"traceutil/trace.go:171","msg":"trace[516563100] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"303.993843ms","start":"2026-02-20T15:47:27.90986Z","end":"2026-02-20T15:47:28.213854Z","steps":["trace[516563100] 'process raft request'  (duration: 298.930802ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:28.213889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.576621ms","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-20T15:47:28.214125Z","caller":"traceutil/trace.go:171","msg":"trace[1449950179] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:943; }","duration":"318.836238ms","start":"2026-02-20T15:47:27.89527Z","end":"2026-02-20T15:47:28.214106Z","steps":["trace[1449950179] 'range keys from in-memory index tree'  (duration: 307.181136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:28.214041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:27.909848Z","time spent":"304.111766ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:939 > 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-20T15:47:28.214197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:27.895265Z","time spent":"318.91131ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T15:47:28.308794Z","caller":"traceutil/trace.go:171","msg":"trace[824162125] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"397.360905ms","start":"2026-02-20T15:47:27.911415Z","end":"2026-02-20T15:47:28.308776Z","steps":["trace[824162125] 'process raft request'  (duration: 397.328654ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:28.308935Z","caller":"traceutil/trace.go:171","msg":"trace[1576889509] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"399.036998ms","start":"2026-02-20T15:47:27.909886Z","end":"2026-02-20T15:47:28.308923Z","steps":["trace[1576889509] 'process raft request'  (duration: 398.7191ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:28.309026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:27.909859Z","time spent":"399.10307ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:942 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-20T15:47:28.309438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:27.911401Z","time spent":"398.013892ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:941 > 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-20T15:47:28.39877Z","caller":"traceutil/trace.go:171","msg":"trace[2016920356] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"180.704786ms","start":"2026-02-20T15:47:28.218035Z","end":"2026-02-20T15:47:28.39874Z","steps":["trace[2016920356] 'process raft request'  (duration: 119.365115ms)","trace[2016920356] 'compare'  (duration: 61.207548ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:30.67005Z","caller":"traceutil/trace.go:171","msg":"trace[982958892] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"343.2131ms","start":"2026-02-20T15:47:30.326804Z","end":"2026-02-20T15:47:30.670017Z","steps":["trace[982958892] 'read index received'  (duration: 342.940233ms)","trace[982958892] 'applied index is now lower than readState.Index'  (duration: 271.867µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:30.670142Z","caller":"traceutil/trace.go:171","msg":"trace[909817292] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"447.685289ms","start":"2026-02-20T15:47:30.222417Z","end":"2026-02-20T15:47:30.670102Z","steps":["trace[909817292] 'process raft request'  (duration: 447.33307ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:30.67032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.222398Z","time spent":"447.829013ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:944 > 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-20T15:47:30.670377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.466177ms","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-20T15:47:30.670413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.548145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:47:30.670366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.527138ms","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-20T15:47:30.670466Z","caller":"traceutil/trace.go:171","msg":"trace[90591140] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:954; }","duration":"343.59466ms","start":"2026-02-20T15:47:30.326846Z","end":"2026-02-20T15:47:30.670441Z","steps":["trace[90591140] 'agreement among raft nodes before linearized reading'  (duration: 343.426436ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:30.670496Z","caller":"traceutil/trace.go:171","msg":"trace[1744275492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:954; }","duration":"162.651088ms","start":"2026-02-20T15:47:30.507827Z","end":"2026-02-20T15:47:30.670478Z","steps":["trace[1744275492] 'agreement among raft nodes before linearized reading'  (duration: 162.526225ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:30.670503Z","caller":"traceutil/trace.go:171","msg":"trace[1393048914] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:954; }","duration":"343.722833ms","start":"2026-02-20T15:47:30.326764Z","end":"2026-02-20T15:47:30.670487Z","steps":["trace[1393048914] 'agreement among raft nodes before linearized reading'  (duration: 343.431576ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:30.670516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.326823Z","time spent":"343.683093ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T15:47:30.670549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.326748Z","time spent":"343.790616ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-20T15:47:30.670628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.135038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-20T15:47:30.67075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.434126ms","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-20T15:47:30.670801Z","caller":"traceutil/trace.go:171","msg":"trace[67092056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:954; }","duration":"267.547578ms","start":"2026-02-20T15:47:30.403242Z","end":"2026-02-20T15:47:30.67079Z","steps":["trace[67092056] 'agreement among raft nodes before linearized reading'  (duration: 267.389744ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:30.670781Z","caller":"traceutil/trace.go:171","msg":"trace[1195942981] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:954; }","duration":"166.333703ms","start":"2026-02-20T15:47:30.504429Z","end":"2026-02-20T15:47:30.670762Z","steps":["trace[1195942981] 'agreement among raft nodes before linearized reading'  (duration: 165.926643ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:31.22088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529307195001680,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T15:47:31.777294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.872027ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001681 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:946 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:47:31.77753Z","caller":"traceutil/trace.go:171","msg":"trace[1091291459] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"1.083663922s","start":"2026-02-20T15:47:30.693831Z","end":"2026-02-20T15:47:31.777495Z","steps":["trace[1091291459] 'process raft request'  (duration: 825.489347ms)","trace[1091291459] 'compare'  (duration: 257.422306ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:31.777566Z","caller":"traceutil/trace.go:171","msg":"trace[986087284] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"1.083291622s","start":"2026-02-20T15:47:30.694254Z","end":"2026-02-20T15:47:31.777545Z","steps":["trace[986087284] 'process raft request'  (duration: 1.083154579s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:31.777647Z","caller":"traceutil/trace.go:171","msg":"trace[2006322378] linearizableReadLoop","detail":"{readStateIndex:1000; appliedIndex:997; }","duration":"1.057267178s","start":"2026-02-20T15:47:30.720349Z","end":"2026-02-20T15:47:31.777617Z","steps":["trace[2006322378] 'read index received'  (duration: 798.991061ms)","trace[2006322378] 'applied index is now lower than readState.Index'  (duration: 258.274867ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:31.777711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.693813Z","time spent":"1.083797206s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:946 > 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-20T15:47:31.777884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057513294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-20T15:47:31.777888Z","caller":"traceutil/trace.go:171","msg":"trace[1707690516] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"1.083505818s","start":"2026-02-20T15:47:30.694349Z","end":"2026-02-20T15:47:31.777855Z","steps":["trace[1707690516] 'process raft request'  (duration: 1.083157539s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:31.77793Z","caller":"traceutil/trace.go:171","msg":"trace[921708249] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:957; }","duration":"1.057633367s","start":"2026-02-20T15:47:30.720285Z","end":"2026-02-20T15:47:31.777919Z","steps":["trace[921708249] 'agreement among raft nodes before linearized reading'  (duration: 1.057439512s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:31.777969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.720256Z","time spent":"1.057704379s","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.52\" "}
{"level":"warn","ts":"2026-02-20T15:47:31.77799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.694216Z","time spent":"1.083398685s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:947 > 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-20T15:47:31.778035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:30.694342Z","time spent":"1.083608131s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:945 > 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-20T15:47:32.028186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.470266ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001687 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.52\" mod_revision:926 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:66 lease:7371157270340225877 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:47:32.028396Z","caller":"traceutil/trace.go:171","msg":"trace[1255688511] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"171.568089ms","start":"2026-02-20T15:47:31.856783Z","end":"2026-02-20T15:47:32.028351Z","steps":["trace[1255688511] 'process raft request'  (duration: 48.819376ms)","trace[1255688511] 'compare'  (duration: 122.304972ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:32.786842Z","caller":"traceutil/trace.go:171","msg":"trace[849202893] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"106.968804ms","start":"2026-02-20T15:47:32.679847Z","end":"2026-02-20T15:47:32.786815Z","steps":["trace[849202893] 'process raft request'  (duration: 106.80297ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:33.72046Z","caller":"traceutil/trace.go:171","msg":"trace[1673493467] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"762.418041ms","start":"2026-02-20T15:47:32.958015Z","end":"2026-02-20T15:47:33.720433Z","steps":["trace[1673493467] 'process raft request'  (duration: 762.250217ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:33.720621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:32.957991Z","time spent":"762.550494ms","remote":"127.0.0.1:60278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":851,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-bnsvw.1895ff0b6ba0b849\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-bnsvw.1895ff0b6ba0b849\" value_size:746 lease:7371157270340225855 >> failure:<>"}
{"level":"warn","ts":"2026-02-20T15:47:34.789674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.302992ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001703 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:956 > 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-20T15:47:34.789938Z","caller":"traceutil/trace.go:171","msg":"trace[1131268514] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1005; }","duration":"721.12975ms","start":"2026-02-20T15:47:34.068788Z","end":"2026-02-20T15:47:34.789918Z","steps":["trace[1131268514] 'read index received'  (duration: 131.440638ms)","trace[1131268514] 'applied index is now lower than readState.Index'  (duration: 589.687482ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:34.790048Z","caller":"traceutil/trace.go:171","msg":"trace[478773676] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"1.002754484s","start":"2026-02-20T15:47:33.78727Z","end":"2026-02-20T15:47:34.790025Z","steps":["trace[478773676] 'process raft request'  (duration: 413.00275ms)","trace[478773676] 'compare'  (duration: 588.848601ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:34.790146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:33.78725Z","time spent":"1.002860656s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:956 > 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-20T15:47:34.790392Z","caller":"traceutil/trace.go:171","msg":"trace[1888093508] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"977.93659ms","start":"2026-02-20T15:47:33.812385Z","end":"2026-02-20T15:47:34.790322Z","steps":["trace[1888093508] 'process raft request'  (duration: 977.496509ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:34.790599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:33.812381Z","time spent":"978.108745ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:957 > 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-20T15:47:34.790686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.902011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-20T15:47:34.790724Z","caller":"traceutil/trace.go:171","msg":"trace[1723873462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"722.010963ms","start":"2026-02-20T15:47:34.068701Z","end":"2026-02-20T15:47:34.790712Z","steps":["trace[1723873462] 'agreement among raft nodes before linearized reading'  (duration: 721.836179ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:34.790756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:34.068654Z","time spent":"722.095596ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T15:47:34.790792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.520547ms","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-20T15:47:34.790791Z","caller":"traceutil/trace.go:171","msg":"trace[1818390699] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"980.309032ms","start":"2026-02-20T15:47:33.810457Z","end":"2026-02-20T15:47:34.790766Z","steps":["trace[1818390699] 'process raft request'  (duration: 979.329007ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:34.790832Z","caller":"traceutil/trace.go:171","msg":"trace[1969925702] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:964; }","duration":"690.597929ms","start":"2026-02-20T15:47:34.100224Z","end":"2026-02-20T15:47:34.790822Z","steps":["trace[1969925702] 'agreement among raft nodes before linearized reading'  (duration: 690.503476ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:34.790855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:34.100207Z","time spent":"690.64332ms","remote":"127.0.0.1:60552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":53,"response size":31,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T15:47:34.790856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.56817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:47:34.790866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.633654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:47:34.79092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:33.810421Z","time spent":"980.425435ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:955 > 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-20T15:47:34.790942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.557124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:34.791Z","caller":"traceutil/trace.go:171","msg":"trace[907807796] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:964; }","duration":"519.679657ms","start":"2026-02-20T15:47:34.271305Z","end":"2026-02-20T15:47:34.790985Z","steps":["trace[907807796] 'agreement among raft nodes before linearized reading'  (duration: 519.609875ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:34.790973Z","caller":"traceutil/trace.go:171","msg":"trace[535850849] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:964; }","duration":"399.774727ms","start":"2026-02-20T15:47:34.391167Z","end":"2026-02-20T15:47:34.790942Z","steps":["trace[535850849] 'agreement among raft nodes before linearized reading'  (duration: 399.607183ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:34.790884Z","caller":"traceutil/trace.go:171","msg":"trace[692303056] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"289.641341ms","start":"2026-02-20T15:47:34.501234Z","end":"2026-02-20T15:47:34.790875Z","steps":["trace[692303056] 'agreement among raft nodes before linearized reading'  (duration: 289.60126ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:34.791057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:34.271279Z","time spent":"519.761749ms","remote":"127.0.0.1:60484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T15:47:34.791159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:34.391141Z","time spent":"399.992273ms","remote":"127.0.0.1:60356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T15:47:35.237545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.280823ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001711 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:959 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:47:35.237656Z","caller":"traceutil/trace.go:171","msg":"trace[97184767] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"441.53725ms","start":"2026-02-20T15:47:34.796098Z","end":"2026-02-20T15:47:35.237635Z","steps":["trace[97184767] 'process raft request'  (duration: 226.070782ms)","trace[97184767] 'compare'  (duration: 214.875002ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:35.23772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:34.796082Z","time spent":"441.610802ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:959 > 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-20T15:47:35.671979Z","caller":"traceutil/trace.go:171","msg":"trace[85445103] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"372.944661ms","start":"2026-02-20T15:47:35.299009Z","end":"2026-02-20T15:47:35.671954Z","steps":["trace[85445103] 'process raft request'  (duration: 372.668544ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:35.672139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:35.298975Z","time spent":"373.075724ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:937 > 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-20T15:47:36.408107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.506998ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001714 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:751 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4832 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:47:36.408245Z","caller":"traceutil/trace.go:171","msg":"trace[345448134] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1010; }","duration":"905.784718ms","start":"2026-02-20T15:47:35.502434Z","end":"2026-02-20T15:47:36.408219Z","steps":["trace[345448134] 'read index received'  (duration: 169.314821ms)","trace[345448134] 'applied index is now lower than readState.Index'  (duration: 736.464597ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:36.408346Z","caller":"traceutil/trace.go:171","msg":"trace[90416314] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"1.059412481s","start":"2026-02-20T15:47:35.348905Z","end":"2026-02-20T15:47:36.408318Z","steps":["trace[90416314] 'process raft request'  (duration: 602.557166ms)","trace[90416314] 'compare'  (duration: 455.671817ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:36.408514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:35.348882Z","time spent":"1.059530475s","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4866,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:751 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4832 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-20T15:47:36.408542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.052385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:36.408683Z","caller":"traceutil/trace.go:171","msg":"trace[864027565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:968; }","duration":"906.25714ms","start":"2026-02-20T15:47:35.50238Z","end":"2026-02-20T15:47:36.408637Z","steps":["trace[864027565] 'agreement among raft nodes before linearized reading'  (duration: 905.952343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:36.408774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:35.502043Z","time spent":"906.692701ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T15:47:37.531014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.122670461s","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001715 > lease_revoke:<id:664b9c7bba2acb04>","response":"size:29"}
{"level":"info","ts":"2026-02-20T15:47:37.531172Z","caller":"traceutil/trace.go:171","msg":"trace[359294396] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"1.122869936s","start":"2026-02-20T15:47:36.408277Z","end":"2026-02-20T15:47:37.531146Z","steps":["trace[359294396] 'read index received'  (duration: 77.612µs)","trace[359294396] 'applied index is now lower than readState.Index'  (duration: 1.122788914s)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:37.531377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323753093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:37.531452Z","caller":"traceutil/trace.go:171","msg":"trace[733753109] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:968; }","duration":"1.323854485s","start":"2026-02-20T15:47:36.207558Z","end":"2026-02-20T15:47:37.531413Z","steps":["trace[733753109] 'agreement among raft nodes before linearized reading'  (duration: 1.323742792s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:37.531523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:36.207539Z","time spent":"1.323965288s","remote":"127.0.0.1:47350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-02-20T15:47:37.531622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121096282s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:37.531724Z","caller":"traceutil/trace.go:171","msg":"trace[2033575002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:968; }","duration":"1.121262867s","start":"2026-02-20T15:47:36.410434Z","end":"2026-02-20T15:47:37.531697Z","steps":["trace[2033575002] 'agreement among raft nodes before linearized reading'  (duration: 1.121100463s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:37.531795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.226864ms","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-20T15:47:37.531812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:36.41041Z","time spent":"1.121358369s","remote":"127.0.0.1:60208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T15:47:37.531793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.716769ms","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-20T15:47:37.531852Z","caller":"traceutil/trace.go:171","msg":"trace[1121534729] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:968; }","duration":"735.334506ms","start":"2026-02-20T15:47:36.796502Z","end":"2026-02-20T15:47:37.531837Z","steps":["trace[1121534729] 'agreement among raft nodes before linearized reading'  (duration: 735.08488ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:37.531873Z","caller":"traceutil/trace.go:171","msg":"trace[1161844938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"289.856573ms","start":"2026-02-20T15:47:37.241995Z","end":"2026-02-20T15:47:37.531852Z","steps":["trace[1161844938] 'agreement among raft nodes before linearized reading'  (duration: 289.607567ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:37.531894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:36.796477Z","time spent":"735.406479ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-20T15:47:37.531966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.082775ms","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-20T15:47:37.532064Z","caller":"traceutil/trace.go:171","msg":"trace[1365332305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:968; }","duration":"736.226538ms","start":"2026-02-20T15:47:36.795805Z","end":"2026-02-20T15:47:37.532031Z","steps":["trace[1365332305] 'agreement among raft nodes before linearized reading'  (duration: 735.90103ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:37.532077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.276986ms","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-20T15:47:37.532118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:36.795781Z","time spent":"736.326911ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T15:47:37.532157Z","caller":"traceutil/trace.go:171","msg":"trace[1508845859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"699.411949ms","start":"2026-02-20T15:47:36.832725Z","end":"2026-02-20T15:47:37.532136Z","steps":["trace[1508845859] 'agreement among raft nodes before linearized reading'  (duration: 699.099221ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:37.53221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:36.832712Z","time spent":"699.48953ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-20T15:47:37.532659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.166521ms","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-20T15:47:37.532736Z","caller":"traceutil/trace.go:171","msg":"trace[66122427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:968; }","duration":"737.293475ms","start":"2026-02-20T15:47:36.795425Z","end":"2026-02-20T15:47:37.532718Z","steps":["trace[66122427] 'agreement among raft nodes before linearized reading'  (duration: 736.67795ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:37.53294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:36.795399Z","time spent":"737.52238ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T15:47:38.022121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.030317ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001720 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:966 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:47:38.022344Z","caller":"traceutil/trace.go:171","msg":"trace[383977935] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"484.587521ms","start":"2026-02-20T15:47:37.537723Z","end":"2026-02-20T15:47:38.02231Z","steps":["trace[383977935] 'process raft request'  (duration: 345.199565ms)","trace[383977935] 'compare'  (duration: 138.884674ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:38.022455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.325595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:38.022488Z","caller":"traceutil/trace.go:171","msg":"trace[721609045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"482.378777ms","start":"2026-02-20T15:47:37.540099Z","end":"2026-02-20T15:47:38.022478Z","steps":["trace[721609045] 'agreement among raft nodes before linearized reading'  (duration: 482.301775ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:38.022528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:37.540091Z","time spent":"482.428558ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T15:47:38.022525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:37.537703Z","time spent":"484.724094ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:966 > 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-20T15:47:38.022586Z","caller":"traceutil/trace.go:171","msg":"trace[2001274289] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"484.785465ms","start":"2026-02-20T15:47:37.53778Z","end":"2026-02-20T15:47:38.022566Z","steps":["trace[2001274289] 'process raft request'  (duration: 484.445807ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:38.022675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:37.537774Z","time spent":"484.854628ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:963 > 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-20T15:47:38.022371Z","caller":"traceutil/trace.go:171","msg":"trace[1963872350] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1014; }","duration":"482.228363ms","start":"2026-02-20T15:47:37.540123Z","end":"2026-02-20T15:47:38.022351Z","steps":["trace[1963872350] 'read index received'  (duration: 64.26517ms)","trace[1963872350] 'applied index is now lower than readState.Index'  (duration: 417.962083ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:47:38.022705Z","caller":"traceutil/trace.go:171","msg":"trace[561924048] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"484.854997ms","start":"2026-02-20T15:47:37.537821Z","end":"2026-02-20T15:47:38.022676Z","steps":["trace[561924048] 'process raft request'  (duration: 484.458887ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:38.022783Z","caller":"traceutil/trace.go:171","msg":"trace[1873341040] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"484.412886ms","start":"2026-02-20T15:47:37.538359Z","end":"2026-02-20T15:47:38.022772Z","steps":["trace[1873341040] 'process raft request'  (duration: 483.958985ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:38.022839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:37.537816Z","time spent":"484.94495ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:962 > 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-20T15:47:38.022844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:37.538348Z","time spent":"484.460658ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:964 > 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-20T15:47:43.910592Z","caller":"traceutil/trace.go:171","msg":"trace[412344242] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"193.395305ms","start":"2026-02-20T15:47:43.717164Z","end":"2026-02-20T15:47:43.910559Z","steps":["trace[412344242] 'process raft request'  (duration: 193.20032ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:49.618628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.438699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:49.618725Z","caller":"traceutil/trace.go:171","msg":"trace[544860793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"117.604733ms","start":"2026-02-20T15:47:49.501097Z","end":"2026-02-20T15:47:49.618702Z","steps":["trace[544860793] 'range keys from in-memory index tree'  (duration: 117.231824ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:47:50.219131Z","caller":"traceutil/trace.go:171","msg":"trace[947639122] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"113.845712ms","start":"2026-02-20T15:47:50.105255Z","end":"2026-02-20T15:47:50.2191Z","steps":["trace[947639122] 'process raft request'  (duration: 62.037446ms)","trace[947639122] 'compare'  (duration: 51.451117ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:47:51.073834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.092973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-20T15:47:51.07394Z","caller":"traceutil/trace.go:171","msg":"trace[1850249764] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:1029; }","duration":"352.279068ms","start":"2026-02-20T15:47:50.721635Z","end":"2026-02-20T15:47:51.073914Z","steps":["trace[1850249764] 'range keys from in-memory index tree'  (duration: 351.730744ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:51.074113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:50.7216Z","time spent":"352.441702ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.52\" "}
{"level":"warn","ts":"2026-02-20T15:47:51.0737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.93547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:51.074217Z","caller":"traceutil/trace.go:171","msg":"trace[2032927745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1029; }","duration":"571.518284ms","start":"2026-02-20T15:47:50.502676Z","end":"2026-02-20T15:47:51.074194Z","steps":["trace[2032927745] 'range keys from in-memory index tree'  (duration: 570.820188ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:47:51.074282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:47:50.502648Z","time spent":"571.618787ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T15:47:51.604929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.605487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:47:51.605046Z","caller":"traceutil/trace.go:171","msg":"trace[847109906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1031; }","duration":"102.798772ms","start":"2026-02-20T15:47:51.50222Z","end":"2026-02-20T15:47:51.605019Z","steps":["trace[847109906] 'range keys from in-memory index tree'  (duration: 102.505435ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:00.125608Z","caller":"traceutil/trace.go:171","msg":"trace[555701652] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"105.227482ms","start":"2026-02-20T15:48:00.020349Z","end":"2026-02-20T15:48:00.125577Z","steps":["trace[555701652] 'process raft request'  (duration: 104.988646ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:01.841184Z","caller":"traceutil/trace.go:171","msg":"trace[438604865] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"228.298518ms","start":"2026-02-20T15:48:01.612838Z","end":"2026-02-20T15:48:01.841136Z","steps":["trace[438604865] 'process raft request'  (duration: 227.912759ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.635199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.232529ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195001985 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1076 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:48:02.635334Z","caller":"traceutil/trace.go:171","msg":"trace[599922838] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"505.094213ms","start":"2026-02-20T15:48:02.130206Z","end":"2026-02-20T15:48:02.6353Z","steps":["trace[599922838] 'read index received'  (duration: 165.668528ms)","trace[599922838] 'applied index is now lower than readState.Index'  (duration: 339.423795ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:48:02.635389Z","caller":"traceutil/trace.go:171","msg":"trace[858327352] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"788.320361ms","start":"2026-02-20T15:48:01.847034Z","end":"2026-02-20T15:48:02.635354Z","steps":["trace[858327352] 'process raft request'  (duration: 448.827485ms)","trace[858327352] 'compare'  (duration: 338.798109ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:48:02.635469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:01.847015Z","time spent":"788.412684ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1076 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-02-20T15:48:02.63578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.261237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:48:02.635855Z","caller":"traceutil/trace.go:171","msg":"trace[651180802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1099; }","duration":"133.370109ms","start":"2026-02-20T15:48:02.502467Z","end":"2026-02-20T15:48:02.635837Z","steps":["trace[651180802] 'agreement among raft nodes before linearized reading'  (duration: 133.192984ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.635857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.055483ms","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-20T15:48:02.63589Z","caller":"traceutil/trace.go:171","msg":"trace[1577043609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1099; }","duration":"422.116935ms","start":"2026-02-20T15:48:02.213764Z","end":"2026-02-20T15:48:02.635881Z","steps":["trace[1577043609] 'agreement among raft nodes before linearized reading'  (duration: 421.983602ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.635917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:02.213751Z","time spent":"422.160256ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T15:48:02.635933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.518799ms","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-20T15:48:02.635998Z","caller":"traceutil/trace.go:171","msg":"trace[1550524029] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1099; }","duration":"326.5914ms","start":"2026-02-20T15:48:02.309389Z","end":"2026-02-20T15:48:02.63598Z","steps":["trace[1550524029] 'agreement among raft nodes before linearized reading'  (duration: 326.247352ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.635989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.703153ms","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-20T15:48:02.635987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.343391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"warn","ts":"2026-02-20T15:48:02.636044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:02.306586Z","time spent":"329.446691ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-20T15:48:02.636069Z","caller":"traceutil/trace.go:171","msg":"trace[704906720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1099; }","duration":"441.892148ms","start":"2026-02-20T15:48:02.194154Z","end":"2026-02-20T15:48:02.636046Z","steps":["trace[704906720] 'agreement among raft nodes before linearized reading'  (duration: 441.464497ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:02.636095Z","caller":"traceutil/trace.go:171","msg":"trace[266791105] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1099; }","duration":"323.454914ms","start":"2026-02-20T15:48:02.312601Z","end":"2026-02-20T15:48:02.636056Z","steps":["trace[266791105] 'agreement among raft nodes before linearized reading'  (duration: 323.238359ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.636121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:02.194133Z","time spent":"441.97718ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T15:48:02.636131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:02.312587Z","time spent":"323.536826ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-20T15:48:02.636219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.358227ms","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-20T15:48:02.636329Z","caller":"traceutil/trace.go:171","msg":"trace[1382114844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1099; }","duration":"331.539161ms","start":"2026-02-20T15:48:02.304761Z","end":"2026-02-20T15:48:02.6363Z","steps":["trace[1382114844] 'agreement among raft nodes before linearized reading'  (duration: 330.939196ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.636396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:02.304734Z","time spent":"331.648234ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T15:48:02.636583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.378594ms","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-20T15:48:02.636644Z","caller":"traceutil/trace.go:171","msg":"trace[1367874787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1099; }","duration":"506.491317ms","start":"2026-02-20T15:48:02.130137Z","end":"2026-02-20T15:48:02.636629Z","steps":["trace[1367874787] 'agreement among raft nodes before linearized reading'  (duration: 505.301178ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:02.636687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:48:02.130109Z","time spent":"506.568708ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-20T15:48:08.892969Z","caller":"traceutil/trace.go:171","msg":"trace[1953517556] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1175; }","duration":"216.860069ms","start":"2026-02-20T15:48:08.67608Z","end":"2026-02-20T15:48:08.89294Z","steps":["trace[1953517556] 'read index received'  (duration: 216.613073ms)","trace[1953517556] 'applied index is now lower than readState.Index'  (duration: 245.616µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:48:08.893083Z","caller":"traceutil/trace.go:171","msg":"trace[228340751] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"217.543306ms","start":"2026-02-20T15:48:08.675509Z","end":"2026-02-20T15:48:08.893052Z","steps":["trace[228340751] 'process raft request'  (duration: 217.208687ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:08.893239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.116515ms","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-20T15:48:08.893299Z","caller":"traceutil/trace.go:171","msg":"trace[182459695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1125; }","duration":"217.226048ms","start":"2026-02-20T15:48:08.676057Z","end":"2026-02-20T15:48:08.893283Z","steps":["trace[182459695] 'agreement among raft nodes before linearized reading'  (duration: 217.022893ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:08.960656Z","caller":"traceutil/trace.go:171","msg":"trace[827827158] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"283.441876ms","start":"2026-02-20T15:48:08.677193Z","end":"2026-02-20T15:48:08.960635Z","steps":["trace[827827158] 'process raft request'  (duration: 283.282102ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:08.9613Z","caller":"traceutil/trace.go:171","msg":"trace[472722870] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"283.317863ms","start":"2026-02-20T15:48:08.677946Z","end":"2026-02-20T15:48:08.961264Z","steps":["trace[472722870] 'process raft request'  (duration: 282.907593ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:08.96143Z","caller":"traceutil/trace.go:171","msg":"trace[989917715] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"283.701122ms","start":"2026-02-20T15:48:08.677244Z","end":"2026-02-20T15:48:08.960945Z","steps":["trace[989917715] 'process raft request'  (duration: 283.351334ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:08.96135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.464482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-02-20T15:48:08.962126Z","caller":"traceutil/trace.go:171","msg":"trace[86998474] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1128; }","duration":"159.253411ms","start":"2026-02-20T15:48:08.802803Z","end":"2026-02-20T15:48:08.962057Z","steps":["trace[86998474] 'agreement among raft nodes before linearized reading'  (duration: 158.39149ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:10.229926Z","caller":"traceutil/trace.go:171","msg":"trace[1195525688] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"153.984982ms","start":"2026-02-20T15:48:10.075911Z","end":"2026-02-20T15:48:10.229896Z","steps":["trace[1195525688] 'process raft request'  (duration: 153.763126ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:11.154171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.704511ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529307195002062 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.52\" mod_revision:1097 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:66 lease:7371157270340226252 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:48:11.15439Z","caller":"traceutil/trace.go:171","msg":"trace[1925304398] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1184; }","duration":"256.688652ms","start":"2026-02-20T15:48:10.897677Z","end":"2026-02-20T15:48:11.154365Z","steps":["trace[1925304398] 'read index received'  (duration: 85.601242ms)","trace[1925304398] 'applied index is now lower than readState.Index'  (duration: 171.08487ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:48:11.154421Z","caller":"traceutil/trace.go:171","msg":"trace[858478034] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"290.313964ms","start":"2026-02-20T15:48:10.864068Z","end":"2026-02-20T15:48:11.154382Z","steps":["trace[858478034] 'process raft request'  (duration: 119.242684ms)","trace[858478034] 'compare'  (duration: 170.506326ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:48:11.154705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.01561ms","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-20T15:48:11.154791Z","caller":"traceutil/trace.go:171","msg":"trace[1901230280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1133; }","duration":"257.168804ms","start":"2026-02-20T15:48:10.897601Z","end":"2026-02-20T15:48:11.15477Z","steps":["trace[1901230280] 'agreement among raft nodes before linearized reading'  (duration: 256.867457ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:11.154828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.501844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"warn","ts":"2026-02-20T15:48:11.154828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.752793ms","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-20T15:48:11.154877Z","caller":"traceutil/trace.go:171","msg":"trace[999209856] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1133; }","duration":"120.598617ms","start":"2026-02-20T15:48:11.034266Z","end":"2026-02-20T15:48:11.154864Z","steps":["trace[999209856] 'agreement among raft nodes before linearized reading'  (duration: 120.412812ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:11.15488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.088332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-20T15:48:11.154896Z","caller":"traceutil/trace.go:171","msg":"trace[1800002799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1133; }","duration":"186.840036ms","start":"2026-02-20T15:48:10.968033Z","end":"2026-02-20T15:48:11.154873Z","steps":["trace[1800002799] 'agreement among raft nodes before linearized reading'  (duration: 186.60479ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:11.154761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.713567ms","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-20T15:48:11.15497Z","caller":"traceutil/trace.go:171","msg":"trace[1365467039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1133; }","duration":"187.197784ms","start":"2026-02-20T15:48:10.967727Z","end":"2026-02-20T15:48:11.154924Z","steps":["trace[1365467039] 'agreement among raft nodes before linearized reading'  (duration: 187.004049ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:11.154998Z","caller":"traceutil/trace.go:171","msg":"trace[1002668897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1133; }","duration":"187.997773ms","start":"2026-02-20T15:48:10.966982Z","end":"2026-02-20T15:48:11.154979Z","steps":["trace[1002668897] 'agreement among raft nodes before linearized reading'  (duration: 187.617514ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:11.155316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.501431ms","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-20T15:48:11.15544Z","caller":"traceutil/trace.go:171","msg":"trace[1520539561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1133; }","duration":"187.653135ms","start":"2026-02-20T15:48:10.967762Z","end":"2026-02-20T15:48:11.155415Z","steps":["trace[1520539561] 'agreement among raft nodes before linearized reading'  (duration: 186.960568ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:11.366954Z","caller":"traceutil/trace.go:171","msg":"trace[2104151097] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"207.694845ms","start":"2026-02-20T15:48:11.159223Z","end":"2026-02-20T15:48:11.366917Z","steps":["trace[2104151097] 'process raft request'  (duration: 207.437099ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:11.367379Z","caller":"traceutil/trace.go:171","msg":"trace[3079133] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"207.786617ms","start":"2026-02-20T15:48:11.15955Z","end":"2026-02-20T15:48:11.367337Z","steps":["trace[3079133] 'process raft request'  (duration: 207.319436ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:11.367452Z","caller":"traceutil/trace.go:171","msg":"trace[1234285987] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"207.732665ms","start":"2026-02-20T15:48:11.159653Z","end":"2026-02-20T15:48:11.367386Z","steps":["trace[1234285987] 'process raft request'  (duration: 207.52254ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:11.36784Z","caller":"traceutil/trace.go:171","msg":"trace[2102030392] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"208.083575ms","start":"2026-02-20T15:48:11.159726Z","end":"2026-02-20T15:48:11.36781Z","steps":["trace[2102030392] 'process raft request'  (duration: 207.604563ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:48:11.367776Z","caller":"traceutil/trace.go:171","msg":"trace[2024345479] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1185; }","duration":"207.372477ms","start":"2026-02-20T15:48:11.160371Z","end":"2026-02-20T15:48:11.367743Z","steps":["trace[2024345479] 'read index received'  (duration: 57.544596ms)","trace[2024345479] 'applied index is now lower than readState.Index'  (duration: 149.755049ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:48:11.367985Z","caller":"traceutil/trace.go:171","msg":"trace[1380197420] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"207.150052ms","start":"2026-02-20T15:48:11.160825Z","end":"2026-02-20T15:48:11.367975Z","steps":["trace[1380197420] 'process raft request'  (duration: 206.710241ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:48:11.368235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.808738ms","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-20T15:48:11.368324Z","caller":"traceutil/trace.go:171","msg":"trace[1227572475] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1139; }","duration":"207.933181ms","start":"2026-02-20T15:48:11.160346Z","end":"2026-02-20T15:48:11.368279Z","steps":["trace[1227572475] 'agreement among raft nodes before linearized reading'  (duration: 207.582103ms)"],"step_count":1}