{"level":"warn","ts":"2026-02-25T19:25:50.297111Z","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-25T19:25:50.297371Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.184:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.184:2380","--initial-cluster=instance=https://199.19.213.184:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.184:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.184: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-25T19:25:50.297487Z","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-25T19:25:50.297531Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.184:2380"]}
{"level":"info","ts":"2026-02-25T19:25:50.297601Z","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-25T19:25:50.298216Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.184:2379"]}
{"level":"info","ts":"2026-02-25T19:25:50.298317Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.184:2380"],"listen-peer-urls":["https://199.19.213.184:2380"],"advertise-client-urls":["https://199.19.213.184:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.184:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.184: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-25T19:25:50.390393Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"91.850847ms"}
{"level":"info","ts":"2026-02-25T19:25:50.878796Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a98e0cfc7e94da4e","cluster-id":"6159be5634512a47"}
{"level":"info","ts":"2026-02-25T19:25:50.878996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T19:25:50.879052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became follower at term 0"}
{"level":"info","ts":"2026-02-25T19:25:50.879132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a98e0cfc7e94da4e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T19:25:50.879211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became follower at term 1"}
{"level":"info","ts":"2026-02-25T19:25:50.879297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e switched to configuration voters=(12217717117697710670)"}
{"level":"warn","ts":"2026-02-25T19:25:50.90275Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T19:25:50.91003Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T19:25:50.923544Z","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-25T19:25:50.93353Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a98e0cfc7e94da4e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T19:25:50.93505Z","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-25T19:25:50.935485Z","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-25T19:25:50.935556Z","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-25T19:25:50.935476Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a98e0cfc7e94da4e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T19:25:50.94064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e switched to configuration voters=(12217717117697710670)"}
{"level":"info","ts":"2026-02-25T19:25:50.940938Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6159be5634512a47","local-member-id":"a98e0cfc7e94da4e","added-peer-id":"a98e0cfc7e94da4e","added-peer-peer-urls":["https://199.19.213.184:2380"]}
{"level":"info","ts":"2026-02-25T19:25:50.941504Z","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-25T19:25:50.941658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.184:2380"}
{"level":"info","ts":"2026-02-25T19:25:50.941717Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.184:2380"}
{"level":"info","ts":"2026-02-25T19:25:50.941849Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a98e0cfc7e94da4e","initial-advertise-peer-urls":["https://199.19.213.184:2380"],"listen-peer-urls":["https://199.19.213.184:2380"],"advertise-client-urls":["https://199.19.213.184:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.184:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T19:25:50.941908Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T19:25:51.381571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T19:25:51.38164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T19:25:51.381673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e received MsgPreVoteResp from a98e0cfc7e94da4e at term 1"}
{"level":"info","ts":"2026-02-25T19:25:51.381695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became candidate at term 2"}
{"level":"info","ts":"2026-02-25T19:25:51.381705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e received MsgVoteResp from a98e0cfc7e94da4e at term 2"}
{"level":"info","ts":"2026-02-25T19:25:51.381721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became leader at term 2"}
{"level":"info","ts":"2026-02-25T19:25:51.381734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a98e0cfc7e94da4e elected leader a98e0cfc7e94da4e at term 2"}
{"level":"info","ts":"2026-02-25T19:25:51.406911Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a98e0cfc7e94da4e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.184:2379]}","request-path":"/0/members/a98e0cfc7e94da4e/attributes","cluster-id":"6159be5634512a47","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T19:25:51.406926Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:25:51.406989Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:25:51.406981Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:25:51.407236Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T19:25:51.407347Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T19:25:51.410684Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T19:25:51.411072Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.184:2379"}
{"level":"info","ts":"2026-02-25T19:25:51.423556Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6159be5634512a47","local-member-id":"a98e0cfc7e94da4e","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:25:51.42394Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:25:51.42406Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-02-25T19:25:52.946799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.371412ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648035968 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T19:25:52.946944Z","caller":"traceutil/trace.go:171","msg":"trace[1539934175] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"260.788566ms","start":"2026-02-25T19:25:52.686137Z","end":"2026-02-25T19:25:52.946926Z","steps":["trace[1539934175] 'process raft request'  (duration: 129.839789ms)","trace[1539934175] 'compare'  (duration: 130.19801ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:52.95422Z","caller":"traceutil/trace.go:171","msg":"trace[1346458960] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"265.615049ms","start":"2026-02-25T19:25:52.688576Z","end":"2026-02-25T19:25:52.954191Z","steps":["trace[1346458960] 'process raft request'  (duration: 265.473218ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.954265Z","caller":"traceutil/trace.go:171","msg":"trace[526144133] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:12; }","duration":"256.375865ms","start":"2026-02-25T19:25:52.697853Z","end":"2026-02-25T19:25:52.954229Z","steps":["trace[526144133] 'read index received'  (duration: 118.260954ms)","trace[526144133] 'applied index is now lower than readState.Index'  (duration: 138.113821ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:52.954397Z","caller":"traceutil/trace.go:171","msg":"trace[80619598] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"243.911344ms","start":"2026-02-25T19:25:52.710473Z","end":"2026-02-25T19:25:52.954385Z","steps":["trace[80619598] 'process raft request'  (duration: 243.660922ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.954392Z","caller":"traceutil/trace.go:171","msg":"trace[1818107763] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"265.671729ms","start":"2026-02-25T19:25:52.688677Z","end":"2026-02-25T19:25:52.954349Z","steps":["trace[1818107763] 'process raft request'  (duration: 265.429897ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.954423Z","caller":"traceutil/trace.go:171","msg":"trace[1395192242] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"266.076633ms","start":"2026-02-25T19:25:52.688333Z","end":"2026-02-25T19:25:52.95441Z","steps":["trace[1395192242] 'process raft request'  (duration: 265.589598ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.954534Z","caller":"traceutil/trace.go:171","msg":"trace[702058613] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"265.958352ms","start":"2026-02-25T19:25:52.688564Z","end":"2026-02-25T19:25:52.954522Z","steps":["trace[702058613] 'process raft request'  (duration: 265.453557ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.954609Z","caller":"traceutil/trace.go:171","msg":"trace[1777541833] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"265.950501ms","start":"2026-02-25T19:25:52.688639Z","end":"2026-02-25T19:25:52.954589Z","steps":["trace[1777541833] 'process raft request'  (duration: 265.442057ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.954701Z","caller":"traceutil/trace.go:171","msg":"trace[2059818640] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"231.191681ms","start":"2026-02-25T19:25:52.723501Z","end":"2026-02-25T19:25:52.954693Z","steps":["trace[2059818640] 'process raft request'  (duration: 230.682537ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:52.954686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.804139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:52.954757Z","caller":"traceutil/trace.go:171","msg":"trace[712436211] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:17; }","duration":"256.906349ms","start":"2026-02-25T19:25:52.697832Z","end":"2026-02-25T19:25:52.954739Z","steps":["trace[712436211] 'agreement among raft nodes before linearized reading'  (duration: 256.625857ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:52.954829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.389597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.184\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:52.954877Z","caller":"traceutil/trace.go:171","msg":"trace[1955502262] range","detail":"{range_begin:/registry/masterleases/199.19.213.184; range_end:; response_count:0; response_revision:17; }","duration":"246.469248ms","start":"2026-02-25T19:25:52.708395Z","end":"2026-02-25T19:25:52.954865Z","steps":["trace[1955502262] 'agreement among raft nodes before linearized reading'  (duration: 246.396917ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:52.955061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.379477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"warn","ts":"2026-02-25T19:25:52.95506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.254274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-02-25T19:25:52.955188Z","caller":"traceutil/trace.go:171","msg":"trace[452263665] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:17; }","duration":"245.56938ms","start":"2026-02-25T19:25:52.709607Z","end":"2026-02-25T19:25:52.955177Z","steps":["trace[452263665] 'agreement among raft nodes before linearized reading'  (duration: 245.414518ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:52.955286Z","caller":"traceutil/trace.go:171","msg":"trace[1922949936] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:17; }","duration":"192.464626ms","start":"2026-02-25T19:25:52.762728Z","end":"2026-02-25T19:25:52.955192Z","steps":["trace[1922949936] 'agreement among raft nodes before linearized reading'  (duration: 192.135013ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.09233Z","caller":"traceutil/trace.go:171","msg":"trace[321571477] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:21; }","duration":"132.059314ms","start":"2026-02-25T19:25:52.960252Z","end":"2026-02-25T19:25:53.092311Z","steps":["trace[321571477] 'read index received'  (duration: 41.255218ms)","trace[321571477] 'applied index is now lower than readState.Index'  (duration: 90.803136ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:53.092539Z","caller":"traceutil/trace.go:171","msg":"trace[1616653760] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"130.204908ms","start":"2026-02-25T19:25:52.962286Z","end":"2026-02-25T19:25:53.092491Z","steps":["trace[1616653760] 'process raft request'  (duration: 129.862504ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.092745Z","caller":"traceutil/trace.go:171","msg":"trace[1284262704] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"130.219078ms","start":"2026-02-25T19:25:52.962274Z","end":"2026-02-25T19:25:53.092493Z","steps":["trace[1284262704] 'process raft request'  (duration: 129.851044ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:53.092809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.528369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"}
{"level":"warn","ts":"2026-02-25T19:25:53.092852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.263486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:53.092874Z","caller":"traceutil/trace.go:171","msg":"trace[1752085690] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"130.645631ms","start":"2026-02-25T19:25:52.962207Z","end":"2026-02-25T19:25:53.092852Z","steps":["trace[1752085690] 'process raft request'  (duration: 129.863043ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.092901Z","caller":"traceutil/trace.go:171","msg":"trace[313245246] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27; }","duration":"132.6741ms","start":"2026-02-25T19:25:52.96021Z","end":"2026-02-25T19:25:53.092885Z","steps":["trace[313245246] 'agreement among raft nodes before linearized reading'  (duration: 132.378168ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.092933Z","caller":"traceutil/trace.go:171","msg":"trace[1481148889] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:27; }","duration":"132.385268ms","start":"2026-02-25T19:25:52.960523Z","end":"2026-02-25T19:25:53.092908Z","steps":["trace[1481148889] 'agreement among raft nodes before linearized reading'  (duration: 132.296827ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.09315Z","caller":"traceutil/trace.go:171","msg":"trace[1790071627] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"124.906281ms","start":"2026-02-25T19:25:52.968188Z","end":"2026-02-25T19:25:53.093095Z","steps":["trace[1790071627] 'process raft request'  (duration: 124.036763ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.093323Z","caller":"traceutil/trace.go:171","msg":"trace[993651570] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"131.401238ms","start":"2026-02-25T19:25:52.961885Z","end":"2026-02-25T19:25:53.093286Z","steps":["trace[993651570] 'process raft request'  (duration: 130.090766ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.093412Z","caller":"traceutil/trace.go:171","msg":"trace[769471031] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"134.716438ms","start":"2026-02-25T19:25:52.958678Z","end":"2026-02-25T19:25:53.093394Z","steps":["trace[769471031] 'process raft request'  (duration: 115.295195ms)","trace[769471031] 'compare'  (duration: 17.709577ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:53.093483Z","caller":"traceutil/trace.go:171","msg":"trace[299891195] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"132.944152ms","start":"2026-02-25T19:25:52.960522Z","end":"2026-02-25T19:25:53.093466Z","steps":["trace[299891195] 'process raft request'  (duration: 131.421448ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.094192Z","caller":"traceutil/trace.go:171","msg":"trace[1187859410] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"134.280394ms","start":"2026-02-25T19:25:52.959367Z","end":"2026-02-25T19:25:53.093648Z","steps":["trace[1187859410] 'process raft request'  (duration: 132.498368ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.092809Z","caller":"traceutil/trace.go:171","msg":"trace[813851690] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"130.908054ms","start":"2026-02-25T19:25:52.961873Z","end":"2026-02-25T19:25:53.092781Z","steps":["trace[813851690] 'process raft request'  (duration: 130.176156ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:53.448526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.410192ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036009 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/flowschemas/system-nodes\" mod_revision:42 > success:<request_put:<key:\"/registry/flowschemas/system-nodes\" value_size:1016 >> failure:<request_range:<key:\"/registry/flowschemas/system-nodes\" > >>","response":"size:14"}
{"level":"info","ts":"2026-02-25T19:25:53.448798Z","caller":"traceutil/trace.go:171","msg":"trace[1469475373] linearizableReadLoop","detail":"{readStateIndex:48; appliedIndex:46; }","duration":"245.307927ms","start":"2026-02-25T19:25:53.203444Z","end":"2026-02-25T19:25:53.448752Z","steps":["trace[1469475373] 'read index received'  (duration: 90.17741ms)","trace[1469475373] 'applied index is now lower than readState.Index'  (duration: 155.129477ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:53.448927Z","caller":"traceutil/trace.go:171","msg":"trace[206671839] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"303.01102ms","start":"2026-02-25T19:25:53.145894Z","end":"2026-02-25T19:25:53.448905Z","steps":["trace[206671839] 'process raft request'  (duration: 147.769941ms)","trace[206671839] 'compare'  (duration: 153.251931ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:53.449029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:53.145871Z","time spent":"303.08879ms","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1058,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/system-nodes\" mod_revision:42 > success:<request_put:<key:\"/registry/flowschemas/system-nodes\" value_size:1016 >> failure:<request_range:<key:\"/registry/flowschemas/system-nodes\" > >"}
{"level":"warn","ts":"2026-02-25T19:25:53.44997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.430588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:53.45005Z","caller":"traceutil/trace.go:171","msg":"trace[884322075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:45; }","duration":"246.521018ms","start":"2026-02-25T19:25:53.203501Z","end":"2026-02-25T19:25:53.450022Z","steps":["trace[884322075] 'agreement among raft nodes before linearized reading'  (duration: 246.160085ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:53.450354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.902661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:53.450431Z","caller":"traceutil/trace.go:171","msg":"trace[1663327677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:45; }","duration":"247.017393ms","start":"2026-02-25T19:25:53.203399Z","end":"2026-02-25T19:25:53.450417Z","steps":["trace[1663327677] 'agreement among raft nodes before linearized reading'  (duration: 246.917942ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:53.44935Z","caller":"traceutil/trace.go:171","msg":"trace[83425314] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"265.263345ms","start":"2026-02-25T19:25:53.184049Z","end":"2026-02-25T19:25:53.449312Z","steps":["trace[83425314] 'process raft request'  (duration: 264.608299ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.131638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.413808002s","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036045 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/flowschemas/global-default\" mod_revision:0 > success:<request_put:<key:\"/registry/flowschemas/global-default\" value_size:658 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T19:25:55.131865Z","caller":"traceutil/trace.go:171","msg":"trace[1623405700] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"1.450787911s","start":"2026-02-25T19:25:53.68106Z","end":"2026-02-25T19:25:55.131847Z","steps":["trace[1623405700] 'process raft request'  (duration: 1.450681239s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:55.1319Z","caller":"traceutil/trace.go:171","msg":"trace[1429286260] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"1.455316632s","start":"2026-02-25T19:25:53.676544Z","end":"2026-02-25T19:25:55.131861Z","steps":["trace[1429286260] 'process raft request'  (duration: 41.220507ms)","trace[1429286260] 'compare'  (duration: 1.4136498s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:55.131951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:53.681042Z","time spent":"1.450865061s","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/kube-system-service-accounts\" mod_revision:59 > success:<request_put:<key:\"/registry/flowschemas/kube-system-service-accounts\" value_size:1062 >> failure:<request_range:<key:\"/registry/flowschemas/kube-system-service-accounts\" > >"}
{"level":"info","ts":"2026-02-25T19:25:55.131865Z","caller":"traceutil/trace.go:171","msg":"trace[1689203748] linearizableReadLoop","detail":"{readStateIndex:67; appliedIndex:66; }","duration":"1.454247033s","start":"2026-02-25T19:25:53.677574Z","end":"2026-02-25T19:25:55.131821Z","steps":["trace[1689203748] 'read index received'  (duration: 40.197538ms)","trace[1689203748] 'applied index is now lower than readState.Index'  (duration: 1.414043285s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:55.132041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:53.676526Z","time spent":"1.455445133s","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":702,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/global-default\" mod_revision:0 > success:<request_put:<key:\"/registry/flowschemas/global-default\" value_size:658 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:25:55.132048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:53.709796Z","time spent":"1.422249128s","remote":"127.0.0.1:60446","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T19:25:55.132203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.715962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:55.132243Z","caller":"traceutil/trace.go:171","msg":"trace[1470900745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:65; }","duration":"129.785942ms","start":"2026-02-25T19:25:55.002446Z","end":"2026-02-25T19:25:55.132232Z","steps":["trace[1470900745] 'agreement among raft nodes before linearized reading'  (duration: 129.726002ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.132182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454527075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-25T19:25:55.132218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170283891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:55.13239Z","caller":"traceutil/trace.go:171","msg":"trace[212075235] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:0; response_revision:65; }","duration":"1.454788417s","start":"2026-02-25T19:25:53.677571Z","end":"2026-02-25T19:25:55.132359Z","steps":["trace[212075235] 'agreement among raft nodes before linearized reading'  (duration: 1.454426184s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.132398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067632162s","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-25T19:25:55.13252Z","caller":"traceutil/trace.go:171","msg":"trace[1131697222] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:65; }","duration":"1.067788774s","start":"2026-02-25T19:25:54.064722Z","end":"2026-02-25T19:25:55.132511Z","steps":["trace[1131697222] 'agreement among raft nodes before linearized reading'  (duration: 1.067643042s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.132596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.0647Z","time spent":"1.067886954s","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "}
{"level":"info","ts":"2026-02-25T19:25:55.132451Z","caller":"traceutil/trace.go:171","msg":"trace[1927802295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:65; }","duration":"1.170581644s","start":"2026-02-25T19:25:53.961852Z","end":"2026-02-25T19:25:55.132434Z","steps":["trace[1927802295] 'agreement among raft nodes before linearized reading'  (duration: 1.170292151s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.132826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:53.961829Z","time spent":"1.170981937s","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:25:55.132555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:53.677542Z","time spent":"1.454991739s","remote":"127.0.0.1:60718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/system:discovery\" "}
{"level":"warn","ts":"2026-02-25T19:25:55.574999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.08131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036058 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/cluster-admin\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/cluster-admin\" value_size:496 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T19:25:55.57533Z","caller":"traceutil/trace.go:171","msg":"trace[702147936] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:71; }","duration":"413.872703ms","start":"2026-02-25T19:25:55.16144Z","end":"2026-02-25T19:25:55.575312Z","steps":["trace[702147936] 'read index received'  (duration: 57.042312ms)","trace[702147936] 'applied index is now lower than readState.Index'  (duration: 356.829441ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:55.575412Z","caller":"traceutil/trace.go:171","msg":"trace[1294259282] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"422.294708ms","start":"2026-02-25T19:25:55.15307Z","end":"2026-02-25T19:25:55.575365Z","steps":["trace[1294259282] 'process raft request'  (duration: 422.187767ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.575489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.022324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:25:55.575527Z","caller":"traceutil/trace.go:171","msg":"trace[1280308389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"414.094705ms","start":"2026-02-25T19:25:55.161423Z","end":"2026-02-25T19:25:55.575518Z","steps":["trace[1280308389] 'agreement among raft nodes before linearized reading'  (duration: 413.972334ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:55.575552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.161416Z","time spent":"414.131085ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:25:55.575583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.153055Z","time spent":"422.447589ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.189793db10a5ce27\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189793db10a5ce27\" value_size:557 lease:6507310680793260239 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:25:55.575377Z","caller":"traceutil/trace.go:171","msg":"trace[343965494] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"422.586189ms","start":"2026-02-25T19:25:55.152747Z","end":"2026-02-25T19:25:55.575333Z","steps":["trace[343965494] 'process raft request'  (duration: 87.105646ms)","trace[343965494] 'compare'  (duration: 334.931299ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:55.575741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.152725Z","time spent":"422.978313ms","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/clusterroles/cluster-admin\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/cluster-admin\" value_size:496 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:25:56.720079Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.033582711s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:25:58.061551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999799722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T19:25:58.061655Z","caller":"traceutil/trace.go:171","msg":"trace[1308360803] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999926714s","start":"2026-02-25T19:25:56.061705Z","end":"2026-02-25T19:25:58.061632Z","steps":["trace[1308360803] 'agreement among raft nodes before linearized reading'  (duration: 1.999796792s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:58.061715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:56.061635Z","time spent":"2.000067904s","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 19:25:58 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:25:59.500882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99987175s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T19:25:59.500993Z","caller":"traceutil/trace.go:171","msg":"trace[1074669833] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000021933s","start":"2026-02-25T19:25:57.500956Z","end":"2026-02-25T19:25:59.500978Z","steps":["trace[1074669833] 'agreement among raft nodes before linearized reading'  (duration: 1.999886111s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:59.501039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:57.500938Z","time spent":"2.000092413s","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:25:59.637194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.950593061s","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036060 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/prioritylevelconfigurations/exempt\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/exempt\" value_size:513 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T19:25:59.637393Z","caller":"traceutil/trace.go:171","msg":"trace[1385818593] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"4.414904199s","start":"2026-02-25T19:25:55.222462Z","end":"2026-02-25T19:25:59.637366Z","steps":["trace[1385818593] 'process raft request'  (duration: 464.043075ms)","trace[1385818593] 'compare'  (duration: 3.949564216s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:59.637458Z","caller":"traceutil/trace.go:171","msg":"trace[178374016] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:77; }","duration":"4.058781525s","start":"2026-02-25T19:25:55.57866Z","end":"2026-02-25T19:25:59.637441Z","steps":["trace[178374016] 'read index received'  (duration: 107.85805ms)","trace[178374016] 'applied index is now lower than readState.Index'  (duration: 3.950922665s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:59.637489Z","caller":"traceutil/trace.go:171","msg":"trace[1207253210] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"4.413664159s","start":"2026-02-25T19:25:55.223801Z","end":"2026-02-25T19:25:59.637465Z","steps":["trace[1207253210] 'process raft request'  (duration: 4.413497946s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:59.637568Z","caller":"traceutil/trace.go:171","msg":"trace[336371377] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"4.058493133s","start":"2026-02-25T19:25:55.579065Z","end":"2026-02-25T19:25:59.637558Z","steps":["trace[336371377] 'process raft request'  (duration: 4.058347251s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:59.637585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.058913197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-25T19:25:59.637619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.579039Z","time spent":"4.058549763s","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.189793db1386d61e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189793db1386d61e\" value_size:574 lease:6507310680793260239 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:25:59.637617Z","caller":"traceutil/trace.go:171","msg":"trace[1770945219] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:76; }","duration":"4.058982187s","start":"2026-02-25T19:25:55.578625Z","end":"2026-02-25T19:25:59.637607Z","steps":["trace[1770945219] 'agreement among raft nodes before linearized reading'  (duration: 4.058896156s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:59.637611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.223785Z","time spent":"4.41375838s","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/kube-scheduler\" mod_revision:58 > success:<request_put:<key:\"/registry/flowschemas/kube-scheduler\" value_size:1045 >> failure:<request_range:<key:\"/registry/flowschemas/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:25:59.637505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.222436Z","time spent":"4.41501171s","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":565,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/exempt\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/exempt\" value_size:513 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:25:59.637655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.578609Z","time spent":"4.059037438s","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:discovery\" "}
{"level":"warn","ts":"2026-02-25T19:25:59.825008Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.104374734s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:26:00.062357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000218077s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T19:26:00.062472Z","caller":"traceutil/trace.go:171","msg":"trace[1849402766] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000386284s","start":"2026-02-25T19:25:58.062068Z","end":"2026-02-25T19:26:00.062454Z","steps":["trace[1849402766] 'agreement among raft nodes before linearized reading'  (duration: 2.000251597s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:00.062523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:58.06205Z","time spent":"2.000463327s","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 19:26:00 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:26:00.99514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169721792s","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036064 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>>","response":"size:4"}
{"level":"info","ts":"2026-02-25T19:26:00.995335Z","caller":"traceutil/trace.go:171","msg":"trace[271151641] transaction","detail":"{read_only:false; number_of_response:0; response_revision:76; }","duration":"4.869894335s","start":"2026-02-25T19:25:56.125416Z","end":"2026-02-25T19:26:00.99531Z","steps":["trace[271151641] 'process raft request'  (duration: 3.699864295s)","trace[271151641] 'compare'  (duration: 1.169602907s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:00.995414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:56.125388Z","time spent":"4.869994438s","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:01.195072Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.369828429s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T19:26:01.195921Z","caller":"traceutil/trace.go:171","msg":"trace[1291809474] linearizableReadLoop","detail":"{readStateIndex:82; appliedIndex:80; }","duration":"1.558399759s","start":"2026-02-25T19:25:59.637492Z","end":"2026-02-25T19:26:01.195892Z","steps":["trace[1291809474] 'read index received'  (duration: 187.782968ms)","trace[1291809474] 'applied index is now lower than readState.Index'  (duration: 1.370615331s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:01.196295Z","caller":"traceutil/trace.go:171","msg":"trace[840878456] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"1.553895962s","start":"2026-02-25T19:25:59.642382Z","end":"2026-02-25T19:26:01.196278Z","steps":["trace[840878456] 'process raft request'  (duration: 1.553403167s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:01.196345Z","caller":"traceutil/trace.go:171","msg":"trace[799246233] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"1.554206449s","start":"2026-02-25T19:25:59.64213Z","end":"2026-02-25T19:26:01.196336Z","steps":["trace[799246233] 'process raft request'  (duration: 1.553608098s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.196422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:59.642369Z","time spent":"1.553982496s","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":581,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/exempt\" mod_revision:0 > success:<request_put:<key:\"/registry/flowschemas/exempt\" value_size:545 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:01.19656Z","caller":"traceutil/trace.go:171","msg":"trace[1870340849] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"3.424144833s","start":"2026-02-25T19:25:57.772289Z","end":"2026-02-25T19:26:01.196434Z","steps":["trace[1870340849] 'process raft request'  (duration: 3.423181344s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.196743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.588795734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2917"}
{"level":"info","ts":"2026-02-25T19:26:01.196793Z","caller":"traceutil/trace.go:171","msg":"trace[7866233] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:81; }","duration":"3.588896757s","start":"2026-02-25T19:25:57.607886Z","end":"2026-02-25T19:26:01.196782Z","steps":["trace[7866233] 'agreement among raft nodes before linearized reading'  (duration: 3.5887814s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.196829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:57.607864Z","time spent":"3.588957239s","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2940,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"info","ts":"2026-02-25T19:26:01.196262Z","caller":"traceutil/trace.go:171","msg":"trace[1299350033] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"1.554131253s","start":"2026-02-25T19:25:59.642098Z","end":"2026-02-25T19:26:01.196229Z","steps":["trace[1299350033] 'process raft request'  (duration: 1.553584765s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.19694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:57.77227Z","time spent":"3.424413925s","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:01.19701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.583920649s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:430"}
{"level":"warn","ts":"2026-02-25T19:26:01.197045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:59.642079Z","time spent":"1.554918693s","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:discovery\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:discovery\" value_size:587 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:01.197099Z","caller":"traceutil/trace.go:171","msg":"trace[1927632283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:81; }","duration":"5.584020783s","start":"2026-02-25T19:25:55.61305Z","end":"2026-02-25T19:26:01.19707Z","steps":["trace[1927632283] 'agreement among raft nodes before linearized reading'  (duration: 5.583792741s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.197153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.61304Z","time spent":"5.584096866s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T19:26:01.196641Z","caller":"traceutil/trace.go:171","msg":"trace[376414828] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"1.553717752s","start":"2026-02-25T19:25:59.642908Z","end":"2026-02-25T19:26:01.196626Z","steps":["trace[376414828] 'process raft request'  (duration: 1.552923342s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.197385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.585482518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T19:26:01.197417Z","caller":"traceutil/trace.go:171","msg":"trace[208524058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:81; }","duration":"5.58555421s","start":"2026-02-25T19:25:55.611854Z","end":"2026-02-25T19:26:01.197408Z","steps":["trace[208524058] 'agreement among raft nodes before linearized reading'  (duration: 5.585496387s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.197444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:55.611829Z","time spent":"5.585608362s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:01.196619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:59.64211Z","time spent":"1.554274481s","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.189793db1387356f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189793db1387356f\" value_size:570 lease:6507310680793260239 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:01.197474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:59.642898Z","time spent":"1.554469722s","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1088,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/service-accounts\" mod_revision:62 > success:<request_put:<key:\"/registry/flowschemas/service-accounts\" value_size:1042 >> failure:<request_range:<key:\"/registry/flowschemas/service-accounts\" > >"}
{"level":"info","ts":"2026-02-25T19:26:01.231333Z","caller":"traceutil/trace.go:171","msg":"trace[491961764] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"879.910748ms","start":"2026-02-25T19:26:00.351377Z","end":"2026-02-25T19:26:01.231287Z","steps":["trace[491961764] 'process raft request'  (duration: 873.473109ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.231437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.275826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3465"}
{"level":"info","ts":"2026-02-25T19:26:01.231517Z","caller":"traceutil/trace.go:171","msg":"trace[1200151910] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:82; }","duration":"234.398452ms","start":"2026-02-25T19:26:00.997095Z","end":"2026-02-25T19:26:01.231494Z","steps":["trace[1200151910] 'agreement among raft nodes before linearized reading'  (duration: 234.205993ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.231602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:00.351352Z","time spent":"880.099308ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:01.231611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070264689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:26:01.231727Z","caller":"traceutil/trace.go:171","msg":"trace[2088492311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:82; }","duration":"1.070462719s","start":"2026-02-25T19:26:00.161241Z","end":"2026-02-25T19:26:01.231704Z","steps":["trace[2088492311] 'agreement among raft nodes before linearized reading'  (duration: 1.070213426s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.231786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:00.161216Z","time spent":"1.070562704s","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:01.232155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231214442s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:26:01.232238Z","caller":"traceutil/trace.go:171","msg":"trace[1716657811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:85; }","duration":"1.231347057s","start":"2026-02-25T19:26:00.000871Z","end":"2026-02-25T19:26:01.232219Z","steps":["trace[1716657811] 'agreement among raft nodes before linearized reading'  (duration: 1.230944947s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.232284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:00.000851Z","time spent":"1.23142382s","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:01.933046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.018417ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036180 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-scheduler-instance.189793db520f270b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-scheduler-instance.189793db520f270b\" value_size:712 lease:6507310680793260239 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:01.933153Z","caller":"traceutil/trace.go:171","msg":"trace[779961843] linearizableReadLoop","detail":"{readStateIndex:145; appliedIndex:144; }","duration":"385.189966ms","start":"2026-02-25T19:26:01.547944Z","end":"2026-02-25T19:26:01.933134Z","steps":["trace[779961843] 'read index received'  (duration: 252.964949ms)","trace[779961843] 'applied index is now lower than readState.Index'  (duration: 132.223637ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:01.93326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.319513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:01.933296Z","caller":"traceutil/trace.go:171","msg":"trace[616556480] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver; range_end:; response_count:0; response_revision:140; }","duration":"385.394697ms","start":"2026-02-25T19:26:01.54789Z","end":"2026-02-25T19:26:01.933285Z","steps":["trace[616556480] 'agreement among raft nodes before linearized reading'  (duration: 385.291361ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:01.933366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:01.547875Z","time spent":"385.451339ms","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" "}
{"level":"info","ts":"2026-02-25T19:26:01.933413Z","caller":"traceutil/trace.go:171","msg":"trace[1988382574] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"389.301677ms","start":"2026-02-25T19:26:01.544051Z","end":"2026-02-25T19:26:01.933353Z","steps":["trace[1988382574] 'process raft request'  (duration: 256.903091ms)","trace[1988382574] 'compare'  (duration: 131.867799ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:01.933602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:01.544024Z","time spent":"389.486927ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-scheduler-instance.189793db520f270b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-scheduler-instance.189793db520f270b\" value_size:712 lease:6507310680793260239 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:02.165238Z","caller":"traceutil/trace.go:171","msg":"trace[592636429] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"130.574114ms","start":"2026-02-25T19:26:02.034622Z","end":"2026-02-25T19:26:02.165196Z","steps":["trace[592636429] 'process raft request'  (duration: 130.340142ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:02.55011Z","caller":"traceutil/trace.go:171","msg":"trace[944208828] linearizableReadLoop","detail":"{readStateIndex:154; appliedIndex:151; }","duration":"288.83374ms","start":"2026-02-25T19:26:02.261247Z","end":"2026-02-25T19:26:02.55008Z","steps":["trace[944208828] 'read index received'  (duration: 218.954005ms)","trace[944208828] 'applied index is now lower than readState.Index'  (duration: 69.878235ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:02.550285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.01821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:02.55033Z","caller":"traceutil/trace.go:171","msg":"trace[144549505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:149; }","duration":"289.127245ms","start":"2026-02-25T19:26:02.261188Z","end":"2026-02-25T19:26:02.550316Z","steps":["trace[144549505] 'agreement among raft nodes before linearized reading'  (duration: 289.010019ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:02.550601Z","caller":"traceutil/trace.go:171","msg":"trace[70132524] transaction","detail":"{read_only:false; response_revision:148; number_of_response:1; }","duration":"370.000135ms","start":"2026-02-25T19:26:02.180588Z","end":"2026-02-25T19:26:02.550588Z","steps":["trace[70132524] 'process raft request'  (duration: 369.398194ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:02.550634Z","caller":"traceutil/trace.go:171","msg":"trace[153932910] transaction","detail":"{read_only:false; response_revision:149; number_of_response:1; }","duration":"369.741822ms","start":"2026-02-25T19:26:02.180859Z","end":"2026-02-25T19:26:02.550601Z","steps":["trace[153932910] 'process raft request'  (duration: 369.175614ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:02.550701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:02.180575Z","time spent":"370.063048ms","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" value_size:615 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:02.55081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:02.180847Z","time spent":"369.879359ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189793db7db62a49\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189793db7db62a49\" value_size:639 lease:6507310680793260239 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:02.550803Z","caller":"traceutil/trace.go:171","msg":"trace[374694108] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"375.472122ms","start":"2026-02-25T19:26:02.175307Z","end":"2026-02-25T19:26:02.55078Z","steps":["trace[374694108] 'process raft request'  (duration: 304.916484ms)","trace[374694108] 'compare'  (duration: 69.604481ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:02.551359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:02.175291Z","time spent":"375.909073ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:109 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6673 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:03.007743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.675509ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036246 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" value_size:990 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:03.007919Z","caller":"traceutil/trace.go:171","msg":"trace[1772766323] transaction","detail":"{read_only:false; response_revision:179; number_of_response:1; }","duration":"194.500945ms","start":"2026-02-25T19:26:02.81339Z","end":"2026-02-25T19:26:03.007891Z","steps":["trace[1772766323] 'process raft request'  (duration: 92.617365ms)","trace[1772766323] 'compare'  (duration: 101.544943ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:03.716794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.777808ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036324 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" value_size:676 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:03.716877Z","caller":"traceutil/trace.go:171","msg":"trace[1719899224] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:222; }","duration":"155.688002ms","start":"2026-02-25T19:26:03.561178Z","end":"2026-02-25T19:26:03.716866Z","steps":["trace[1719899224] 'read index received'  (duration: 30.8078ms)","trace[1719899224] 'applied index is now lower than readState.Index'  (duration: 124.879422ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:03.716982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.795988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:03.717004Z","caller":"traceutil/trace.go:171","msg":"trace[603116100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:218; }","duration":"155.868132ms","start":"2026-02-25T19:26:03.56113Z","end":"2026-02-25T19:26:03.716998Z","steps":["trace[603116100] 'agreement among raft nodes before linearized reading'  (duration: 155.766817ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:03.717104Z","caller":"traceutil/trace.go:171","msg":"trace[1319188946] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"331.219877ms","start":"2026-02-25T19:26:03.385836Z","end":"2026-02-25T19:26:03.717056Z","steps":["trace[1319188946] 'process raft request'  (duration: 206.115673ms)","trace[1319188946] 'compare'  (duration: 124.641171ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:03.717276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:03.385815Z","time spent":"331.378895ms","remote":"127.0.0.1:60718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" value_size:676 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:03.909991Z","caller":"traceutil/trace.go:171","msg":"trace[1278954897] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"152.44099ms","start":"2026-02-25T19:26:03.757517Z","end":"2026-02-25T19:26:03.909958Z","steps":["trace[1278954897] 'process raft request'  (duration: 85.364827ms)","trace[1278954897] 'compare'  (duration: 66.877263ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:04.223555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.045684ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036333 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" value_size:679 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:04.223638Z","caller":"traceutil/trace.go:171","msg":"trace[1401153157] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:226; }","duration":"154.346005ms","start":"2026-02-25T19:26:04.069279Z","end":"2026-02-25T19:26:04.223625Z","steps":["trace[1401153157] 'read index received'  (duration: 38.792µs)","trace[1401153157] 'applied index is now lower than readState.Index'  (duration: 154.306513ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:04.223736Z","caller":"traceutil/trace.go:171","msg":"trace[2100231928] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"307.6582ms","start":"2026-02-25T19:26:03.916031Z","end":"2026-02-25T19:26:04.223689Z","steps":["trace[2100231928] 'process raft request'  (duration: 110.428456ms)","trace[2100231928] 'compare'  (duration: 196.94102ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:04.2238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.515794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4324"}
{"level":"info","ts":"2026-02-25T19:26:04.223832Z","caller":"traceutil/trace.go:171","msg":"trace[1501217671] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:222; }","duration":"154.587036ms","start":"2026-02-25T19:26:04.069238Z","end":"2026-02-25T19:26:04.223825Z","steps":["trace[1501217671] 'agreement among raft nodes before linearized reading'  (duration: 154.420178ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:04.223862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:03.916005Z","time spent":"307.796547ms","remote":"127.0.0.1:60718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" value_size:679 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:04.347446Z","caller":"traceutil/trace.go:171","msg":"trace[108564675] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"116.365728ms","start":"2026-02-25T19:26:04.231009Z","end":"2026-02-25T19:26:04.347374Z","steps":["trace[108564675] 'process raft request'  (duration: 103.182097ms)","trace[108564675] 'compare'  (duration: 12.994722ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:04.806396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.138106ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036361 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" value_size:682 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:04.806636Z","caller":"traceutil/trace.go:171","msg":"trace[1550380928] linearizableReadLoop","detail":"{readStateIndex:241; appliedIndex:240; }","duration":"245.5062ms","start":"2026-02-25T19:26:04.561112Z","end":"2026-02-25T19:26:04.806619Z","steps":["trace[1550380928] 'read index received'  (duration: 127.106791ms)","trace[1550380928] 'applied index is now lower than readState.Index'  (duration: 118.397609ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:04.806667Z","caller":"traceutil/trace.go:171","msg":"trace[2043861610] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"266.153849ms","start":"2026-02-25T19:26:04.54049Z","end":"2026-02-25T19:26:04.806644Z","steps":["trace[2043861610] 'process raft request'  (duration: 147.700677ms)","trace[2043861610] 'compare'  (duration: 117.937617ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:04.806818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.706669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:04.806876Z","caller":"traceutil/trace.go:171","msg":"trace[2034278295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:236; }","duration":"245.797854ms","start":"2026-02-25T19:26:04.561068Z","end":"2026-02-25T19:26:04.806866Z","steps":["trace[2034278295] 'agreement among raft nodes before linearized reading'  (duration: 245.626766ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:05.175341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.414998ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036372 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" value_size:679 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:05.175688Z","caller":"traceutil/trace.go:171","msg":"trace[2074744249] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"268.944628ms","start":"2026-02-25T19:26:04.906504Z","end":"2026-02-25T19:26:05.175449Z","steps":["trace[2074744249] 'process raft request'  (duration: 104.34068ms)","trace[2074744249] 'compare'  (duration: 164.227049ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:05.353981Z","caller":"traceutil/trace.go:171","msg":"trace[352440576] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:247; }","duration":"102.137387ms","start":"2026-02-25T19:26:05.251812Z","end":"2026-02-25T19:26:05.353949Z","steps":["trace[352440576] 'read index received'  (duration: 44.376037ms)","trace[352440576] 'applied index is now lower than readState.Index'  (duration: 57.7601ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:05.354154Z","caller":"traceutil/trace.go:171","msg":"trace[1482849268] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"142.092498ms","start":"2026-02-25T19:26:05.211928Z","end":"2026-02-25T19:26:05.354021Z","steps":["trace[1482849268] 'process raft request'  (duration: 84.323007ms)","trace[1482849268] 'compare'  (duration: 57.517608ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:05.354239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.413671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-25T19:26:05.354289Z","caller":"traceutil/trace.go:171","msg":"trace[1643660758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:243; }","duration":"102.528907ms","start":"2026-02-25T19:26:05.251745Z","end":"2026-02-25T19:26:05.354274Z","steps":["trace[1643660758] 'agreement among raft nodes before linearized reading'  (duration: 102.38803ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:05.957589Z","caller":"traceutil/trace.go:171","msg":"trace[1810303113] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"318.440899ms","start":"2026-02-25T19:26:05.639123Z","end":"2026-02-25T19:26:05.957564Z","steps":["trace[1810303113] 'process raft request'  (duration: 228.401313ms)","trace[1810303113] 'compare'  (duration: 89.884068ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:05.957719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:05.639072Z","time spent":"318.585556ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":838,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-controller-manager\" value_size:749 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:06.299253Z","caller":"traceutil/trace.go:171","msg":"trace[1377151203] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"120.276295ms","start":"2026-02-25T19:26:06.178947Z","end":"2026-02-25T19:26:06.299223Z","steps":["trace[1377151203] 'process raft request'  (duration: 38.874996ms)","trace[1377151203] 'compare'  (duration: 81.143966ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:07.435946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.036719ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036498 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/kube-system/bootstrap-token-mddcsl\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/bootstrap-token-mddcsl\" value_size:465 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:07.436047Z","caller":"traceutil/trace.go:171","msg":"trace[1734776503] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:294; }","duration":"234.011274ms","start":"2026-02-25T19:26:07.202021Z","end":"2026-02-25T19:26:07.436032Z","steps":["trace[1734776503] 'read index received'  (duration: 27.736293ms)","trace[1734776503] 'applied index is now lower than readState.Index'  (duration: 206.274021ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:07.436076Z","caller":"traceutil/trace.go:171","msg":"trace[153931911] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"282.609691ms","start":"2026-02-25T19:26:07.153451Z","end":"2026-02-25T19:26:07.436061Z","steps":["trace[153931911] 'process raft request'  (duration: 76.390913ms)","trace[153931911] 'compare'  (duration: 205.887212ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:07.436193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.174051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-25T19:26:07.436233Z","caller":"traceutil/trace.go:171","msg":"trace[1279443236] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:289; }","duration":"234.245745ms","start":"2026-02-25T19:26:07.201977Z","end":"2026-02-25T19:26:07.436223Z","steps":["trace[1279443236] 'agreement among raft nodes before linearized reading'  (duration: 234.13918ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:07.764048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.638064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036508 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:254 > 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-25T19:26:07.764655Z","caller":"traceutil/trace.go:171","msg":"trace[250060844] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"260.529798ms","start":"2026-02-25T19:26:07.504104Z","end":"2026-02-25T19:26:07.764633Z","steps":["trace[250060844] 'process raft request'  (duration: 34.220302ms)","trace[250060844] 'compare'  (duration: 225.524649ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:07.800301Z","caller":"traceutil/trace.go:171","msg":"trace[753581586] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"293.993355ms","start":"2026-02-25T19:26:07.506264Z","end":"2026-02-25T19:26:07.800257Z","steps":["trace[753581586] 'process raft request'  (duration: 293.782215ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:07.800356Z","caller":"traceutil/trace.go:171","msg":"trace[2098829738] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"295.869335ms","start":"2026-02-25T19:26:07.504421Z","end":"2026-02-25T19:26:07.800291Z","steps":["trace[2098829738] 'process raft request'  (duration: 295.501937ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:08.075625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.84052ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036515 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:104 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5273 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:08.075865Z","caller":"traceutil/trace.go:171","msg":"trace[1537598844] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"229.192173ms","start":"2026-02-25T19:26:07.846654Z","end":"2026-02-25T19:26:08.075846Z","steps":["trace[1537598844] 'process raft request'  (duration: 229.100179ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:08.075899Z","caller":"traceutil/trace.go:171","msg":"trace[948377404] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"266.391958ms","start":"2026-02-25T19:26:07.809454Z","end":"2026-02-25T19:26:08.075846Z","steps":["trace[948377404] 'process raft request'  (duration: 143.113447ms)","trace[948377404] 'compare'  (duration: 122.496354ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:08.076163Z","caller":"traceutil/trace.go:171","msg":"trace[1804318187] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:301; }","duration":"266.574876ms","start":"2026-02-25T19:26:07.809556Z","end":"2026-02-25T19:26:08.076131Z","steps":["trace[1804318187] 'read index received'  (duration: 32.26952ms)","trace[1804318187] 'applied index is now lower than readState.Index'  (duration: 234.302696ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:08.076362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.767035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:08.076412Z","caller":"traceutil/trace.go:171","msg":"trace[995779296] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:298; }","duration":"266.879191ms","start":"2026-02-25T19:26:07.809519Z","end":"2026-02-25T19:26:08.076399Z","steps":["trace[995779296] 'agreement among raft nodes before linearized reading'  (duration: 266.733544ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:08.612286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.955605ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036521 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:297 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5101 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:08.612453Z","caller":"traceutil/trace.go:171","msg":"trace[308749652] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"498.681586ms","start":"2026-02-25T19:26:08.113746Z","end":"2026-02-25T19:26:08.612427Z","steps":["trace[308749652] 'read index received'  (duration: 283.327431ms)","trace[308749652] 'applied index is now lower than readState.Index'  (duration: 215.352575ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:08.612493Z","caller":"traceutil/trace.go:171","msg":"trace[767501300] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"526.030485ms","start":"2026-02-25T19:26:08.08642Z","end":"2026-02-25T19:26:08.612451Z","steps":["trace[767501300] 'process raft request'  (duration: 310.754183ms)","trace[767501300] 'compare'  (duration: 214.696714ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:08.612658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.885385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:26:08.612712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:08.086398Z","time spent":"526.197493ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:297 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5101 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >"}
{"level":"info","ts":"2026-02-25T19:26:08.612761Z","caller":"traceutil/trace.go:171","msg":"trace[1187497155] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:300; }","duration":"499.057813ms","start":"2026-02-25T19:26:08.113671Z","end":"2026-02-25T19:26:08.612729Z","steps":["trace[1187497155] 'agreement among raft nodes before linearized reading'  (duration: 498.874734ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:08.612837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:08.113655Z","time spent":"499.171628ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" "}
{"level":"warn","ts":"2026-02-25T19:26:09.183243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.799722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036525 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:287 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3950 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:09.183417Z","caller":"traceutil/trace.go:171","msg":"trace[363078680] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"562.756029ms","start":"2026-02-25T19:26:08.620645Z","end":"2026-02-25T19:26:09.183401Z","steps":["trace[363078680] 'process raft request'  (duration: 562.703557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:09.183481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:08.620627Z","time spent":"562.830863ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" value_size:129 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:09.183612Z","caller":"traceutil/trace.go:171","msg":"trace[1977462988] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"563.1697ms","start":"2026-02-25T19:26:08.620325Z","end":"2026-02-25T19:26:09.183495Z","steps":["trace[1977462988] 'process raft request'  (duration: 218.043762ms)","trace[1977462988] 'compare'  (duration: 344.600043ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:09.183934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:08.620313Z","time spent":"563.430092ms","remote":"127.0.0.1:60556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3984,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:287 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3950 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:09.564542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.866947ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036530 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/kube-system/bootstrap-token-f56e88\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/bootstrap-token-f56e88\" value_size:617 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:09.564778Z","caller":"traceutil/trace.go:171","msg":"trace[344725181] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"372.745556ms","start":"2026-02-25T19:26:09.191993Z","end":"2026-02-25T19:26:09.564739Z","steps":["trace[344725181] 'process raft request'  (duration: 372.649062ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:09.564936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:09.191978Z","time spent":"372.885203ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/deployment-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/deployment-controller\" value_size:126 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:09.564977Z","caller":"traceutil/trace.go:171","msg":"trace[850719749] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"374.632983ms","start":"2026-02-25T19:26:09.190261Z","end":"2026-02-25T19:26:09.564894Z","steps":["trace[850719749] 'process raft request'  (duration: 192.348626ms)","trace[850719749] 'compare'  (duration: 181.72268ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:09.565208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:09.19024Z","time spent":"374.866224ms","remote":"127.0.0.1:60470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/bootstrap-token-f56e88\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/bootstrap-token-f56e88\" value_size:617 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:10.556783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.466786ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036610 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3276 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-02-25T19:26:10.556861Z","caller":"traceutil/trace.go:171","msg":"trace[932354143] transaction","detail":"{read_only:false; number_of_response:0; response_revision:342; }","duration":"366.848416ms","start":"2026-02-25T19:26:10.190002Z","end":"2026-02-25T19:26:10.55685Z","steps":["trace[932354143] 'process raft request'  (duration: 173.273125ms)","trace[932354143] 'compare'  (duration: 193.424854ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:10.556893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.189984Z","time spent":"366.895797ms","remote":"127.0.0.1:60556","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3276 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:10.558199Z","caller":"traceutil/trace.go:171","msg":"trace[397997893] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:348; }","duration":"338.95749ms","start":"2026-02-25T19:26:10.219232Z","end":"2026-02-25T19:26:10.558189Z","steps":["trace[397997893] 'read index received'  (duration: 144.055679ms)","trace[397997893] 'applied index is now lower than readState.Index'  (duration: 194.901241ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:10.558262Z","caller":"traceutil/trace.go:171","msg":"trace[56030414] transaction","detail":"{read_only:false; number_of_response:0; response_revision:343; }","duration":"349.046925ms","start":"2026-02-25T19:26:10.209203Z","end":"2026-02-25T19:26:10.558249Z","steps":["trace[56030414] 'process raft request'  (duration: 348.95469ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:10.558295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.209192Z","time spent":"349.086096ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:10.558274Z","caller":"traceutil/trace.go:171","msg":"trace[1038222639] transaction","detail":"{read_only:false; number_of_response:0; response_revision:343; }","duration":"349.36996ms","start":"2026-02-25T19:26:10.208884Z","end":"2026-02-25T19:26:10.558254Z","steps":["trace[1038222639] 'process raft request'  (duration: 349.258355ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:10.558391Z","caller":"traceutil/trace.go:171","msg":"trace[1960840447] transaction","detail":"{read_only:false; number_of_response:0; response_revision:343; }","duration":"348.232287ms","start":"2026-02-25T19:26:10.210153Z","end":"2026-02-25T19:26:10.558386Z","steps":["trace[1960840447] 'process raft request'  (duration: 348.020437ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:10.558416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.210125Z","time spent":"348.279809ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:10.558428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.208851Z","time spent":"349.497296ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5824 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:10.558526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.294316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:10.55855Z","caller":"traceutil/trace.go:171","msg":"trace[558136433] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:343; }","duration":"339.343447ms","start":"2026-02-25T19:26:10.2192Z","end":"2026-02-25T19:26:10.558544Z","steps":["trace[558136433] 'agreement among raft nodes before linearized reading'  (duration: 339.285334ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:10.558566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.219191Z","time spent":"339.371079ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" "}
{"level":"info","ts":"2026-02-25T19:26:10.558604Z","caller":"traceutil/trace.go:171","msg":"trace[1163196715] transaction","detail":"{read_only:false; number_of_response:0; response_revision:343; }","duration":"349.707865ms","start":"2026-02-25T19:26:10.208887Z","end":"2026-02-25T19:26:10.558595Z","steps":["trace[1163196715] 'process raft request'  (duration: 349.235424ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:10.558583Z","caller":"traceutil/trace.go:171","msg":"trace[1803427168] transaction","detail":"{read_only:false; number_of_response:0; response_revision:343; }","duration":"349.777928ms","start":"2026-02-25T19:26:10.208772Z","end":"2026-02-25T19:26:10.55855Z","steps":["trace[1803427168] 'process raft request'  (duration: 349.322258ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:10.558657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.208863Z","time spent":"349.772178ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:10.558731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.208757Z","time spent":"349.906265ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:10.558774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.024708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"}
{"level":"info","ts":"2026-02-25T19:26:10.558792Z","caller":"traceutil/trace.go:171","msg":"trace[63563880] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:343; }","duration":"289.078661ms","start":"2026-02-25T19:26:10.269709Z","end":"2026-02-25T19:26:10.558787Z","steps":["trace[63563880] 'agreement among raft nodes before linearized reading'  (duration: 289.04801ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:10.558732Z","caller":"traceutil/trace.go:171","msg":"trace[1326577803] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"366.9474ms","start":"2026-02-25T19:26:10.191728Z","end":"2026-02-25T19:26:10.558676Z","steps":["trace[1326577803] 'process raft request'  (duration: 366.27744ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:10.559024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:10.191719Z","time spent":"367.155979ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.189793e05a1bbbc3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189793e05a1bbbc3\" value_size:574 lease:6507310680793260239 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:11.561483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.372646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036658 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:228 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:11.561657Z","caller":"traceutil/trace.go:171","msg":"trace[1587765086] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:368; }","duration":"341.885606ms","start":"2026-02-25T19:26:11.219755Z","end":"2026-02-25T19:26:11.561641Z","steps":["trace[1587765086] 'read index received'  (duration: 226.213116ms)","trace[1587765086] 'applied index is now lower than readState.Index'  (duration: 115.67155ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:11.561855Z","caller":"traceutil/trace.go:171","msg":"trace[2124296986] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"352.211176ms","start":"2026-02-25T19:26:11.20958Z","end":"2026-02-25T19:26:11.561791Z","steps":["trace[2124296986] 'process raft request'  (duration: 352.008486ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.56196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.209549Z","time spent":"352.361002ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-6bgm7\" mod_revision:2 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-6bgm7\" value_size:1197 >> failure:<request_range:<key:\"/registry/certificatesigningrequests/csr-6bgm7\" > >"}
{"level":"info","ts":"2026-02-25T19:26:11.562081Z","caller":"traceutil/trace.go:171","msg":"trace[1235288933] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"353.089066ms","start":"2026-02-25T19:26:11.208909Z","end":"2026-02-25T19:26:11.561998Z","steps":["trace[1235288933] 'process raft request'  (duration: 237.130593ms)","trace[1235288933] 'compare'  (duration: 115.210739ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:11.562282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.208892Z","time spent":"353.290886ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:228 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:11.562319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.080433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-02-25T19:26:11.562474Z","caller":"traceutil/trace.go:171","msg":"trace[1274943415] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:356; }","duration":"293.23959ms","start":"2026-02-25T19:26:11.26918Z","end":"2026-02-25T19:26:11.56242Z","steps":["trace[1274943415] 'agreement among raft nodes before linearized reading'  (duration: 293.072843ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.562622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.912482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6754"}
{"level":"warn","ts":"2026-02-25T19:26:11.562701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.12215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5335"}
{"level":"info","ts":"2026-02-25T19:26:11.562728Z","caller":"traceutil/trace.go:171","msg":"trace[772494999] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:356; }","duration":"133.975964ms","start":"2026-02-25T19:26:11.428686Z","end":"2026-02-25T19:26:11.562662Z","steps":["trace[772494999] 'agreement among raft nodes before linearized reading'  (duration: 133.88233ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.562794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.32968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"}
{"level":"info","ts":"2026-02-25T19:26:11.562825Z","caller":"traceutil/trace.go:171","msg":"trace[322547126] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:356; }","duration":"134.368752ms","start":"2026-02-25T19:26:11.428448Z","end":"2026-02-25T19:26:11.562817Z","steps":["trace[322547126] 'agreement among raft nodes before linearized reading'  (duration: 134.31606ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.563009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.866379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7301"}
{"level":"warn","ts":"2026-02-25T19:26:11.563034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.660195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-02-25T19:26:11.56307Z","caller":"traceutil/trace.go:171","msg":"trace[1282438733] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:356; }","duration":"134.725258ms","start":"2026-02-25T19:26:11.428335Z","end":"2026-02-25T19:26:11.56306Z","steps":["trace[1282438733] 'agreement among raft nodes before linearized reading'  (duration: 134.641084ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:11.563055Z","caller":"traceutil/trace.go:171","msg":"trace[707636792] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:356; }","duration":"133.934622ms","start":"2026-02-25T19:26:11.429109Z","end":"2026-02-25T19:26:11.563043Z","steps":["trace[707636792] 'agreement among raft nodes before linearized reading'  (duration: 133.848819ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.563285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.167803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4325"}
{"level":"info","ts":"2026-02-25T19:26:11.563326Z","caller":"traceutil/trace.go:171","msg":"trace[1469419485] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:356; }","duration":"134.218075ms","start":"2026-02-25T19:26:11.429098Z","end":"2026-02-25T19:26:11.563316Z","steps":["trace[1469419485] 'agreement among raft nodes before linearized reading'  (duration: 134.149422ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.563583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.492117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4662"}
{"level":"info","ts":"2026-02-25T19:26:11.563651Z","caller":"traceutil/trace.go:171","msg":"trace[544369015] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:356; }","duration":"134.54326ms","start":"2026-02-25T19:26:11.429069Z","end":"2026-02-25T19:26:11.563612Z","steps":["trace[544369015] 'agreement among raft nodes before linearized reading'  (duration: 134.476767ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:11.562743Z","caller":"traceutil/trace.go:171","msg":"trace[289672183] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:356; }","duration":"134.175253ms","start":"2026-02-25T19:26:11.428557Z","end":"2026-02-25T19:26:11.562733Z","steps":["trace[289672183] 'agreement among raft nodes before linearized reading'  (duration: 134.09813ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.564076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.210436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"warn","ts":"2026-02-25T19:26:11.5641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.340168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-02-25T19:26:11.564117Z","caller":"traceutil/trace.go:171","msg":"trace[610050053] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:356; }","duration":"244.286079ms","start":"2026-02-25T19:26:11.319821Z","end":"2026-02-25T19:26:11.564107Z","steps":["trace[610050053] 'agreement among raft nodes before linearized reading'  (duration: 244.213936ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:11.564139Z","caller":"traceutil/trace.go:171","msg":"trace[1368130119] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:356; }","duration":"344.409091ms","start":"2026-02-25T19:26:11.219722Z","end":"2026-02-25T19:26:11.564131Z","steps":["trace[1368130119] 'agreement among raft nodes before linearized reading'  (duration: 344.346728ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.564156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.219706Z","time spent":"344.446232ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"warn","ts":"2026-02-25T19:26:11.564236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.639189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T19:26:11.564271Z","caller":"traceutil/trace.go:171","msg":"trace[1741812786] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:356; }","duration":"144.705912ms","start":"2026-02-25T19:26:11.419554Z","end":"2026-02-25T19:26:11.56426Z","steps":["trace[1741812786] 'agreement among raft nodes before linearized reading'  (duration: 144.641569ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:11.564334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.764432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-02-25T19:26:11.564355Z","caller":"traceutil/trace.go:171","msg":"trace[1146099609] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:356; }","duration":"194.811235ms","start":"2026-02-25T19:26:11.369537Z","end":"2026-02-25T19:26:11.564348Z","steps":["trace[1146099609] 'agreement among raft nodes before linearized reading'  (duration: 194.773044ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:12.105669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.767114ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648036698 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/etcd-instance.189793e0b8891a77\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/etcd-instance.189793e0b8891a77\" value_size:565 lease:6507310680793260239 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:12.106008Z","caller":"traceutil/trace.go:171","msg":"trace[1363675265] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"330.279443ms","start":"2026-02-25T19:26:11.7757Z","end":"2026-02-25T19:26:12.105979Z","steps":["trace[1363675265] 'process raft request'  (duration: 93.131183ms)","trace[1363675265] 'compare'  (duration: 235.518717ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:12.106165Z","caller":"traceutil/trace.go:171","msg":"trace[2209179] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"330.226951ms","start":"2026-02-25T19:26:11.775907Z","end":"2026-02-25T19:26:12.106134Z","steps":["trace[2209179] 'process raft request'  (duration: 329.874456ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:12.10634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.775898Z","time spent":"330.372547ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/default\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/default\" value_size:112 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:26:12.106289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.775679Z","time spent":"330.379618ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/etcd-instance.189793e0b8891a77\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/etcd-instance.189793e0b8891a77\" value_size:565 lease:6507310680793260239 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:12.106681Z","caller":"traceutil/trace.go:171","msg":"trace[1737905462] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:389; }","duration":"330.817178ms","start":"2026-02-25T19:26:11.775846Z","end":"2026-02-25T19:26:12.106663Z","steps":["trace[1737905462] 'read index received'  (duration: 92.922914ms)","trace[1737905462] 'applied index is now lower than readState.Index'  (duration: 237.892714ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:12.106867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.006376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-02-25T19:26:12.10692Z","caller":"traceutil/trace.go:171","msg":"trace[640348767] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:377; }","duration":"331.067079ms","start":"2026-02-25T19:26:11.775841Z","end":"2026-02-25T19:26:12.106908Z","steps":["trace[640348767] 'agreement among raft nodes before linearized reading'  (duration: 330.930053ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:12.106948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.775778Z","time spent":"331.164963ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "}
{"level":"warn","ts":"2026-02-25T19:26:12.107328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.295235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T19:26:12.107359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.944563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-02-25T19:26:12.107431Z","caller":"traceutil/trace.go:171","msg":"trace[539645490] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:378; }","duration":"187.062098ms","start":"2026-02-25T19:26:11.920351Z","end":"2026-02-25T19:26:12.107413Z","steps":["trace[539645490] 'agreement among raft nodes before linearized reading'  (duration: 186.921982ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:12.107499Z","caller":"traceutil/trace.go:171","msg":"trace[535092155] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"326.740281ms","start":"2026-02-25T19:26:11.780748Z","end":"2026-02-25T19:26:12.107488Z","steps":["trace[535092155] 'process raft request'  (duration: 326.289471ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:12.107557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.780733Z","time spent":"326.787353ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:369 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4729 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >"}
{"level":"info","ts":"2026-02-25T19:26:12.107386Z","caller":"traceutil/trace.go:171","msg":"trace[1780179604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:378; }","duration":"314.389759ms","start":"2026-02-25T19:26:11.792982Z","end":"2026-02-25T19:26:12.107372Z","steps":["trace[1780179604] 'agreement among raft nodes before linearized reading'  (duration: 314.239912ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:12.107438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.446269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T19:26:12.107717Z","caller":"traceutil/trace.go:171","msg":"trace[1307147529] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:378; }","duration":"238.739222ms","start":"2026-02-25T19:26:11.868951Z","end":"2026-02-25T19:26:12.10769Z","steps":["trace[1307147529] 'agreement among raft nodes before linearized reading'  (duration: 238.460219ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:12.107616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:11.792968Z","time spent":"314.6308ms","remote":"127.0.0.1:60626","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-25T19:26:12.10828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.663297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T19:26:12.108327Z","caller":"traceutil/trace.go:171","msg":"trace[1309115691] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:378; }","duration":"288.73357ms","start":"2026-02-25T19:26:11.819583Z","end":"2026-02-25T19:26:12.108316Z","steps":["trace[1309115691] 'agreement among raft nodes before linearized reading'  (duration: 288.655866ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:28.006539Z","caller":"traceutil/trace.go:171","msg":"trace[1511212235] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"122.49999ms","start":"2026-02-25T19:26:27.884013Z","end":"2026-02-25T19:26:28.006513Z","steps":["trace[1511212235] 'process raft request'  (duration: 108.519527ms)","trace[1511212235] 'compare'  (duration: 13.610648ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:30.163524Z","caller":"traceutil/trace.go:171","msg":"trace[1129276349] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"152.353821ms","start":"2026-02-25T19:26:30.011133Z","end":"2026-02-25T19:26:30.163486Z","steps":["trace[1129276349] 'read index received'  (duration: 152.106912ms)","trace[1129276349] 'applied index is now lower than readState.Index'  (duration: 245.439µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:30.163948Z","caller":"traceutil/trace.go:171","msg":"trace[1565411745] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"275.522817ms","start":"2026-02-25T19:26:29.888407Z","end":"2026-02-25T19:26:30.163929Z","steps":["trace[1565411745] 'process raft request'  (duration: 274.874413ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:30.163987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.835509ms","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-25T19:26:30.164086Z","caller":"traceutil/trace.go:171","msg":"trace[1022377090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:489; }","duration":"153.009496ms","start":"2026-02-25T19:26:30.011048Z","end":"2026-02-25T19:26:30.164058Z","steps":["trace[1022377090] 'agreement among raft nodes before linearized reading'  (duration: 152.84791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:36.665692Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037006,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:26:36.689108Z","caller":"traceutil/trace.go:171","msg":"trace[601660622] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:556; }","duration":"524.009546ms","start":"2026-02-25T19:26:36.165067Z","end":"2026-02-25T19:26:36.689076Z","steps":["trace[601660622] 'read index received'  (duration: 523.788519ms)","trace[601660622] 'applied index is now lower than readState.Index'  (duration: 219.657µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:36.689213Z","caller":"traceutil/trace.go:171","msg":"trace[1552417489] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"992.206679ms","start":"2026-02-25T19:26:35.696962Z","end":"2026-02-25T19:26:36.689169Z","steps":["trace[1552417489] 'process raft request'  (duration: 991.95214ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:36.689356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:35.696944Z","time spent":"992.335272ms","remote":"127.0.0.1:60556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:436 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:36.689325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.225354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.184\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-02-25T19:26:36.689392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.050545ms","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-25T19:26:36.689422Z","caller":"traceutil/trace.go:171","msg":"trace[1779216594] range","detail":"{range_begin:/registry/masterleases/199.19.213.184; range_end:; response_count:1; response_revision:537; }","duration":"524.37542ms","start":"2026-02-25T19:26:36.165026Z","end":"2026-02-25T19:26:36.689402Z","steps":["trace[1779216594] 'agreement among raft nodes before linearized reading'  (duration: 524.209534ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:36.689398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.669739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T19:26:36.689472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.447441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:26:36.689481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.165007Z","time spent":"524.454162ms","remote":"127.0.0.1:60412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.184\" "}
{"level":"info","ts":"2026-02-25T19:26:36.689489Z","caller":"traceutil/trace.go:171","msg":"trace[1535431401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"356.800924ms","start":"2026-02-25T19:26:36.332666Z","end":"2026-02-25T19:26:36.689467Z","steps":["trace[1535431401] 'agreement among raft nodes before linearized reading'  (duration: 356.606497ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:36.689548Z","caller":"traceutil/trace.go:171","msg":"trace[1188722115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"109.570505ms","start":"2026-02-25T19:26:36.579959Z","end":"2026-02-25T19:26:36.68953Z","steps":["trace[1188722115] 'agreement among raft nodes before linearized reading'  (duration: 109.467602ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:36.68955Z","caller":"traceutil/trace.go:171","msg":"trace[70446681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"436.134688ms","start":"2026-02-25T19:26:36.253298Z","end":"2026-02-25T19:26:36.689432Z","steps":["trace[70446681] 'agreement among raft nodes before linearized reading'  (duration: 436.008813ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:36.689587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.332649Z","time spent":"356.928468ms","remote":"127.0.0.1:60626","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-25T19:26:36.689569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.854352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"warn","ts":"2026-02-25T19:26:36.689599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.253289Z","time spent":"436.297353ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-25T19:26:36.689659Z","caller":"traceutil/trace.go:171","msg":"trace[2046957219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"436.961876ms","start":"2026-02-25T19:26:36.252676Z","end":"2026-02-25T19:26:36.689638Z","steps":["trace[2046957219] 'agreement among raft nodes before linearized reading'  (duration: 436.709277ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:36.689704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.252622Z","time spent":"437.07388ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:36.689892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.869332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-25T19:26:36.690192Z","caller":"traceutil/trace.go:171","msg":"trace[154023283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"499.234804ms","start":"2026-02-25T19:26:36.190939Z","end":"2026-02-25T19:26:36.690174Z","steps":["trace[154023283] 'agreement among raft nodes before linearized reading'  (duration: 498.306322ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:36.690251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.190916Z","time spent":"499.320928ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:37.818186Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.125941593s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:26:38.433868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.742085366s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:38.433929Z","caller":"traceutil/trace.go:171","msg":"trace[311132910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"1.742208561s","start":"2026-02-25T19:26:36.691707Z","end":"2026-02-25T19:26:38.433915Z","steps":["trace[311132910] 'range keys from in-memory index tree'  (duration: 1.741987683s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:38.433956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.691664Z","time spent":"1.742286473s","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:38.434366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.926815ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648037012 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:5a4e9c9643c9a493>","response":"size:40"}
{"level":"warn","ts":"2026-02-25T19:26:38.434737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.692094Z","time spent":"1.742633274s","remote":"127.0.0.1:60412","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-25T19:26:38.434798Z","caller":"traceutil/trace.go:171","msg":"trace[699662283] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.739161834s","start":"2026-02-25T19:26:36.695612Z","end":"2026-02-25T19:26:38.434774Z","steps":["trace[699662283] 'process raft request'  (duration: 1.739111882s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:38.434839Z","caller":"traceutil/trace.go:171","msg":"trace[1688539280] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.739545998s","start":"2026-02-25T19:26:36.695282Z","end":"2026-02-25T19:26:38.434828Z","steps":["trace[1688539280] 'process raft request'  (duration: 1.73932813s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:38.43484Z","caller":"traceutil/trace.go:171","msg":"trace[1873577429] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.740307323s","start":"2026-02-25T19:26:36.694514Z","end":"2026-02-25T19:26:38.434821Z","steps":["trace[1873577429] 'process raft request'  (duration: 1.739966422s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:38.434886Z","caller":"traceutil/trace.go:171","msg":"trace[1833063942] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.739429003s","start":"2026-02-25T19:26:36.69543Z","end":"2026-02-25T19:26:38.434859Z","steps":["trace[1833063942] 'process raft request'  (duration: 1.739251617s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:38.434921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.695269Z","time spent":"1.739597999s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:533 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:38.43493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.694494Z","time spent":"1.740387557s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:535 > 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-25T19:26:38.43492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.695603Z","time spent":"1.739241546s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:532 > 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-25T19:26:38.435051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:36.695402Z","time spent":"1.739549787s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:531 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:26:40.393859Z","caller":"traceutil/trace.go:171","msg":"trace[1032394881] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"121.841817ms","start":"2026-02-25T19:26:40.271991Z","end":"2026-02-25T19:26:40.393833Z","steps":["trace[1032394881] 'process raft request'  (duration: 116.487947ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:40.939916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037034,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:26:41.387711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.365231ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648037042 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/local-path-provisioner\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/local-path-provisioner\" value_size:1038 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:41.387801Z","caller":"traceutil/trace.go:171","msg":"trace[742017021] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"948.249645ms","start":"2026-02-25T19:26:40.439537Z","end":"2026-02-25T19:26:41.387787Z","steps":["trace[742017021] 'read index received'  (duration: 641.764349ms)","trace[742017021] 'applied index is now lower than readState.Index'  (duration: 306.484186ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:41.387922Z","caller":"traceutil/trace.go:171","msg":"trace[2028747534] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"964.078785ms","start":"2026-02-25T19:26:40.423778Z","end":"2026-02-25T19:26:41.387857Z","steps":["trace[2028747534] 'process raft request'  (duration: 657.513497ms)","trace[2028747534] 'compare'  (duration: 306.278338ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:41.387963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.421891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-25T19:26:41.388007Z","caller":"traceutil/trace.go:171","msg":"trace[219365220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"948.503403ms","start":"2026-02-25T19:26:40.439488Z","end":"2026-02-25T19:26:41.387991Z","steps":["trace[219365220] 'agreement among raft nodes before linearized reading'  (duration: 948.40208ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:41.388038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:40.439462Z","time spent":"948.569426ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:41.388702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:40.423753Z","time spent":"964.23842ms","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1091,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/local-path-provisioner\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/local-path-provisioner\" value_size:1038 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:26:41.394355Z","caller":"traceutil/trace.go:171","msg":"trace[357364135] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"331.908917ms","start":"2026-02-25T19:26:41.062427Z","end":"2026-02-25T19:26:41.394336Z","steps":["trace[357364135] 'process raft request'  (duration: 331.796474ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:41.394433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.427267ms","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-25T19:26:41.394448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.923299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:26:41.394449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.809013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-25T19:26:41.39448Z","caller":"traceutil/trace.go:171","msg":"trace[2121508628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"953.48924ms","start":"2026-02-25T19:26:40.440978Z","end":"2026-02-25T19:26:41.394467Z","steps":["trace[2121508628] 'agreement among raft nodes before linearized reading'  (duration: 953.372775ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:41.394479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:41.062406Z","time spent":"332.015942ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:493 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-25T19:26:41.394502Z","caller":"traceutil/trace.go:171","msg":"trace[954002468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"954.899396ms","start":"2026-02-25T19:26:40.439588Z","end":"2026-02-25T19:26:41.394487Z","steps":["trace[954002468] 'agreement among raft nodes before linearized reading'  (duration: 954.75084ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:41.39449Z","caller":"traceutil/trace.go:171","msg":"trace[1996088945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:551; }","duration":"814.029422ms","start":"2026-02-25T19:26:40.580448Z","end":"2026-02-25T19:26:41.394477Z","steps":["trace[1996088945] 'agreement among raft nodes before linearized reading'  (duration: 813.929959ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:41.394515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:40.440974Z","time spent":"953.531811ms","remote":"127.0.0.1:60626","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-25T19:26:41.394544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:40.580418Z","time spent":"814.118415ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:41.39454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:40.439573Z","time spent":"954.957518ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:41.394551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.666895ms","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-25T19:26:41.394604Z","caller":"traceutil/trace.go:171","msg":"trace[791758672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"953.767149ms","start":"2026-02-25T19:26:40.440825Z","end":"2026-02-25T19:26:41.394592Z","steps":["trace[791758672] 'agreement among raft nodes before linearized reading'  (duration: 953.575112ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:41.39464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:40.4408Z","time spent":"953.828171ms","remote":"127.0.0.1:60626","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-25T19:26:41.664781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.340646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648037053 > lease_revoke:<id:5a4e9c9643c9a419>","response":"size:28"}
{"level":"info","ts":"2026-02-25T19:26:41.665056Z","caller":"traceutil/trace.go:171","msg":"trace[744936629] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"172.968962ms","start":"2026-02-25T19:26:41.49207Z","end":"2026-02-25T19:26:41.665039Z","steps":["trace[744936629] 'process raft request'  (duration: 172.829497ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:41.689524Z","caller":"traceutil/trace.go:171","msg":"trace[2098587322] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"193.292635ms","start":"2026-02-25T19:26:41.496208Z","end":"2026-02-25T19:26:41.689501Z","steps":["trace[2098587322] 'process raft request'  (duration: 193.130149ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:42.049253Z","caller":"traceutil/trace.go:171","msg":"trace[96819902] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"152.290562ms","start":"2026-02-25T19:26:41.89694Z","end":"2026-02-25T19:26:42.04923Z","steps":["trace[96819902] 'read index received'  (duration: 145.274212ms)","trace[96819902] 'applied index is now lower than readState.Index'  (duration: 7.01541ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:42.049312Z","caller":"traceutil/trace.go:171","msg":"trace[470799799] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"154.758743ms","start":"2026-02-25T19:26:41.894534Z","end":"2026-02-25T19:26:42.049293Z","steps":["trace[470799799] 'process raft request'  (duration: 147.669801ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:42.049568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.595232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"}
{"level":"info","ts":"2026-02-25T19:26:42.049724Z","caller":"traceutil/trace.go:171","msg":"trace[2020945094] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:568; }","duration":"152.787808ms","start":"2026-02-25T19:26:41.896909Z","end":"2026-02-25T19:26:42.049697Z","steps":["trace[2020945094] 'agreement among raft nodes before linearized reading'  (duration: 152.484268ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:43.624994Z","caller":"traceutil/trace.go:171","msg":"trace[615876051] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"151.602797ms","start":"2026-02-25T19:26:43.473376Z","end":"2026-02-25T19:26:43.624979Z","steps":["trace[615876051] 'process raft request'  (duration: 151.525805ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:43.624974Z","caller":"traceutil/trace.go:171","msg":"trace[754740305] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"151.825764ms","start":"2026-02-25T19:26:43.473129Z","end":"2026-02-25T19:26:43.624955Z","steps":["trace[754740305] 'process raft request'  (duration: 148.812786ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:47.619525Z","caller":"traceutil/trace.go:171","msg":"trace[1202210688] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"103.046853ms","start":"2026-02-25T19:26:47.516418Z","end":"2026-02-25T19:26:47.619465Z","steps":["trace[1202210688] 'process raft request'  (duration: 102.896689ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:47.777908Z","caller":"traceutil/trace.go:171","msg":"trace[1578369946] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"136.83078ms","start":"2026-02-25T19:26:47.64105Z","end":"2026-02-25T19:26:47.777881Z","steps":["trace[1578369946] 'read index received'  (duration: 76.174744ms)","trace[1578369946] 'applied index is now lower than readState.Index'  (duration: 60.655056ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:47.778092Z","caller":"traceutil/trace.go:171","msg":"trace[303901721] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"155.911266ms","start":"2026-02-25T19:26:47.622118Z","end":"2026-02-25T19:26:47.778029Z","steps":["trace[303901721] 'process raft request'  (duration: 95.111515ms)","trace[303901721] 'compare'  (duration: 60.536573ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:47.778258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.15837ms","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-25T19:26:47.778373Z","caller":"traceutil/trace.go:171","msg":"trace[537775523] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"137.273864ms","start":"2026-02-25T19:26:47.641027Z","end":"2026-02-25T19:26:47.7783Z","steps":["trace[537775523] 'agreement among raft nodes before linearized reading'  (duration: 136.988826ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:49.95764Z","caller":"traceutil/trace.go:171","msg":"trace[2096982874] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"147.099006ms","start":"2026-02-25T19:26:49.810518Z","end":"2026-02-25T19:26:49.957618Z","steps":["trace[2096982874] 'read index received'  (duration: 147.066395ms)","trace[2096982874] 'applied index is now lower than readState.Index'  (duration: 31.471µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:49.957767Z","caller":"traceutil/trace.go:171","msg":"trace[1398895037] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"171.835325ms","start":"2026-02-25T19:26:49.785916Z","end":"2026-02-25T19:26:49.957752Z","steps":["trace[1398895037] 'process raft request'  (duration: 171.571857ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:49.957988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.467257ms","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-25T19:26:49.958024Z","caller":"traceutil/trace.go:171","msg":"trace[1532363803] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"147.549739ms","start":"2026-02-25T19:26:49.810465Z","end":"2026-02-25T19:26:49.958015Z","steps":["trace[1532363803] 'agreement among raft nodes before linearized reading'  (duration: 147.423555ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:49.958152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.99432ms","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-25T19:26:49.958181Z","caller":"traceutil/trace.go:171","msg":"trace[1161573131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"144.049242ms","start":"2026-02-25T19:26:49.814124Z","end":"2026-02-25T19:26:49.958174Z","steps":["trace[1161573131] 'agreement among raft nodes before linearized reading'  (duration: 143.9719ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:52.514151Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037133,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:26:52.601042Z","caller":"traceutil/trace.go:171","msg":"trace[512010414] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"587.387833ms","start":"2026-02-25T19:26:52.013618Z","end":"2026-02-25T19:26:52.601006Z","steps":["trace[512010414] 'read index received'  (duration: 587.102124ms)","trace[512010414] 'applied index is now lower than readState.Index'  (duration: 283.939µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:52.601117Z","caller":"traceutil/trace.go:171","msg":"trace[938668721] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"636.917102ms","start":"2026-02-25T19:26:51.96415Z","end":"2026-02-25T19:26:52.601067Z","steps":["trace[938668721] 'process raft request'  (duration: 636.660594ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:52.601489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:51.964124Z","time spent":"637.257962ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:585 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:52.688891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.253546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-25T19:26:52.689265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.421331ms","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-25T19:26:52.689344Z","caller":"traceutil/trace.go:171","msg":"trace[1853522637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"673.528384ms","start":"2026-02-25T19:26:52.015798Z","end":"2026-02-25T19:26:52.689327Z","steps":["trace[1853522637] 'agreement among raft nodes before linearized reading'  (duration: 585.395782ms)","trace[1853522637] 'range keys from in-memory index tree'  (duration: 87.939356ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:52.689383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:52.015794Z","time spent":"673.583365ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:52.689348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.525484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jq9b8\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-02-25T19:26:52.689348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.310194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:52.689276Z","caller":"traceutil/trace.go:171","msg":"trace[1898605840] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:593; }","duration":"675.668278ms","start":"2026-02-25T19:26:52.013571Z","end":"2026-02-25T19:26:52.689239Z","steps":["trace[1898605840] 'agreement among raft nodes before linearized reading'  (duration: 587.606309ms)","trace[1898605840] 'count revisions from in-memory index tree'  (duration: 87.645338ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:52.689524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:52.013545Z","time spent":"675.964627ms","remote":"127.0.0.1:60798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T19:26:52.689181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.746047ms","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-25T19:26:52.689614Z","caller":"traceutil/trace.go:171","msg":"trace[1548219876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"629.224102ms","start":"2026-02-25T19:26:52.060381Z","end":"2026-02-25T19:26:52.689605Z","steps":["trace[1548219876] 'agreement among raft nodes before linearized reading'  (duration: 540.848512ms)","trace[1548219876] 'range keys from in-memory index tree'  (duration: 87.811582ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:52.689636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:52.06036Z","time spent":"629.269514ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-25T19:26:52.689613Z","caller":"traceutil/trace.go:171","msg":"trace[174013140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"108.542831ms","start":"2026-02-25T19:26:52.580949Z","end":"2026-02-25T19:26:52.689491Z","steps":["trace[174013140] 'agreement among raft nodes before linearized reading'  (duration: 20.262055ms)","trace[174013140] 'range keys from in-memory index tree'  (duration: 88.045909ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:52.689452Z","caller":"traceutil/trace.go:171","msg":"trace[856770165] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jq9b8; range_end:; response_count:1; response_revision:593; }","duration":"454.649668ms","start":"2026-02-25T19:26:52.234774Z","end":"2026-02-25T19:26:52.689423Z","steps":["trace[856770165] 'agreement among raft nodes before linearized reading'  (duration: 366.441494ms)","trace[856770165] 'range keys from in-memory index tree'  (duration: 87.903115ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:52.689941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:52.234726Z","time spent":"455.159303ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-jq9b8\" "}
{"level":"info","ts":"2026-02-25T19:26:53.075513Z","caller":"traceutil/trace.go:171","msg":"trace[1292466033] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"374.071081ms","start":"2026-02-25T19:26:52.701421Z","end":"2026-02-25T19:26:53.075492Z","steps":["trace[1292466033] 'process raft request'  (duration: 373.949158ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:53.075607Z","caller":"traceutil/trace.go:171","msg":"trace[1153621167] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"378.946997ms","start":"2026-02-25T19:26:52.696634Z","end":"2026-02-25T19:26:53.075581Z","steps":["trace[1153621167] 'process raft request'  (duration: 378.597167ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:53.075758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:52.696618Z","time spent":"379.064941ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:587 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:53.075779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:52.701398Z","time spent":"374.302438ms","remote":"127.0.0.1:60562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jq9b8\" mod_revision:530 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jq9b8\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jq9b8\" > >"}
{"level":"info","ts":"2026-02-25T19:26:54.174566Z","caller":"traceutil/trace.go:171","msg":"trace[849361529] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"500.243559ms","start":"2026-02-25T19:26:53.674293Z","end":"2026-02-25T19:26:54.174537Z","steps":["trace[849361529] 'process raft request'  (duration: 500.064954ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:54.174751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:53.674272Z","time spent":"500.385413ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:592 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:54.517419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.420099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T19:26:54.517511Z","caller":"traceutil/trace.go:171","msg":"trace[47371228] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:597; }","duration":"245.560382ms","start":"2026-02-25T19:26:54.27193Z","end":"2026-02-25T19:26:54.517491Z","steps":["trace[47371228] 'count revisions from in-memory index tree'  (duration: 245.352676ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:54.517491Z","caller":"traceutil/trace.go:171","msg":"trace[1530672689] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"198.79564ms","start":"2026-02-25T19:26:54.318666Z","end":"2026-02-25T19:26:54.517462Z","steps":["trace[1530672689] 'process raft request'  (duration: 133.981869ms)","trace[1530672689] 'compare'  (duration: 64.688788ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:55.245556Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037148,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:26:55.746118Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037148,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:26:55.970982Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.361842376s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T19:26:56.036306Z","caller":"traceutil/trace.go:171","msg":"trace[1169335983] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"1.291308942s","start":"2026-02-25T19:26:54.744975Z","end":"2026-02-25T19:26:56.036284Z","steps":["trace[1169335983] 'read index received'  (duration: 1.2262483s)","trace[1169335983] 'applied index is now lower than readState.Index'  (duration: 65.059702ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:56.036545Z","caller":"traceutil/trace.go:171","msg":"trace[414676286] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.427463665s","start":"2026-02-25T19:26:54.609064Z","end":"2026-02-25T19:26:56.036528Z","steps":["trace[414676286] 'process raft request'  (duration: 1.362142285s)","trace[414676286] 'compare'  (duration: 64.985751ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:56.036663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:54.609054Z","time spent":"1.427534867s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:593 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:56.0369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.2919292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-25T19:26:56.036938Z","caller":"traceutil/trace.go:171","msg":"trace[745397755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"1.291966381s","start":"2026-02-25T19:26:54.744959Z","end":"2026-02-25T19:26:56.036926Z","steps":["trace[745397755] 'agreement among raft nodes before linearized reading'  (duration: 1.291843508s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:56.036967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:54.744886Z","time spent":"1.292074404s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:56.037097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.243014ms","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-25T19:26:56.037134Z","caller":"traceutil/trace.go:171","msg":"trace[1963715661] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"957.314366ms","start":"2026-02-25T19:26:55.079811Z","end":"2026-02-25T19:26:56.037125Z","steps":["trace[1963715661] 'agreement among raft nodes before linearized reading'  (duration: 957.228684ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:56.037177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:55.079791Z","time spent":"957.361078ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:26:56.037179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.272252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:56.037225Z","caller":"traceutil/trace.go:171","msg":"trace[25351163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"456.358236ms","start":"2026-02-25T19:26:55.580854Z","end":"2026-02-25T19:26:56.037212Z","steps":["trace[25351163] 'agreement among raft nodes before linearized reading'  (duration: 456.278553ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:56.037256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:55.580832Z","time spent":"456.417727ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:56.666502Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037152,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:26:57.166765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037152,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:26:57.66731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15730682717648037152,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:26:57.927708Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.886925565s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:26:58.157935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.874475ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648037153 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:595 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:26:58.15805Z","caller":"traceutil/trace.go:171","msg":"trace[1608394078] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"2.117335686s","start":"2026-02-25T19:26:56.040695Z","end":"2026-02-25T19:26:58.158031Z","steps":["trace[1608394078] 'process raft request'  (duration: 1.887233873s)","trace[1608394078] 'compare'  (duration: 229.586757ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:26:58.158111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:56.040676Z","time spent":"2.117404678s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:595 > 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-25T19:26:58.38838Z","caller":"traceutil/trace.go:171","msg":"trace[1591986028] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"2.222587233s","start":"2026-02-25T19:26:56.165765Z","end":"2026-02-25T19:26:58.388352Z","steps":["trace[1591986028] 'read index received'  (duration: 1.762171091s)","trace[1591986028] 'applied index is now lower than readState.Index'  (duration: 460.415062ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:58.388758Z","caller":"traceutil/trace.go:171","msg":"trace[312269] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"2.347257154s","start":"2026-02-25T19:26:56.041493Z","end":"2026-02-25T19:26:58.38875Z","steps":["trace[312269] 'process raft request'  (duration: 2.345397421s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:58.388868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:56.041468Z","time spent":"2.347314125s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:594 > 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-25T19:26:58.389096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.223338504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.184\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T19:26:58.389124Z","caller":"traceutil/trace.go:171","msg":"trace[762255353] range","detail":"{range_begin:/registry/masterleases/199.19.213.184; range_end:; response_count:1; response_revision:601; }","duration":"2.223394225s","start":"2026-02-25T19:26:56.165721Z","end":"2026-02-25T19:26:58.389116Z","steps":["trace[762255353] 'agreement among raft nodes before linearized reading'  (duration: 2.223286872s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:58.389142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:56.165702Z","time spent":"2.223436617s","remote":"127.0.0.1:60412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.184\" "}
{"level":"warn","ts":"2026-02-25T19:26:58.389279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.210038681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T19:26:58.389298Z","caller":"traceutil/trace.go:171","msg":"trace[1914873980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"2.210077611s","start":"2026-02-25T19:26:56.179215Z","end":"2026-02-25T19:26:58.389293Z","steps":["trace[1914873980] 'agreement among raft nodes before linearized reading'  (duration: 2.21002733s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:58.389313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:56.179201Z","time spent":"2.210107483s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:26:58.389622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.711602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T19:26:58.389643Z","caller":"traceutil/trace.go:171","msg":"trace[1541849614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"347.756643ms","start":"2026-02-25T19:26:58.041881Z","end":"2026-02-25T19:26:58.389638Z","steps":["trace[1541849614] 'agreement among raft nodes before linearized reading'  (duration: 347.702981ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:58.389657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:58.041868Z","time spent":"347.785814ms","remote":"127.0.0.1:60626","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-25T19:26:58.390668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.785719505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:58.390775Z","caller":"traceutil/trace.go:171","msg":"trace[1702018160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"1.786371744s","start":"2026-02-25T19:26:56.604378Z","end":"2026-02-25T19:26:58.39075Z","steps":["trace[1702018160] 'agreement among raft nodes before linearized reading'  (duration: 1.785381325s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:58.390827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:56.604362Z","time spent":"1.786450677s","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:59.867782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.767588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:59.867841Z","caller":"traceutil/trace.go:171","msg":"trace[520524004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"301.885191ms","start":"2026-02-25T19:26:59.565942Z","end":"2026-02-25T19:26:59.867827Z","steps":["trace[520524004] 'range keys from in-memory index tree'  (duration: 301.665575ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:59.867875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:59.565914Z","time spent":"301.955833ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:26:59.867877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.921129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:26:59.867935Z","caller":"traceutil/trace.go:171","msg":"trace[677104743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"288.006781ms","start":"2026-02-25T19:26:59.579914Z","end":"2026-02-25T19:26:59.867921Z","steps":["trace[677104743] 'range keys from in-memory index tree'  (duration: 287.847887ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:00.472695Z","caller":"traceutil/trace.go:171","msg":"trace[1891030268] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"100.886227ms","start":"2026-02-25T19:27:00.371789Z","end":"2026-02-25T19:27:00.472675Z","steps":["trace[1891030268] 'process raft request'  (duration: 40.340272ms)","trace[1891030268] 'compare'  (duration: 60.456832ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:27:00.653803Z","caller":"traceutil/trace.go:171","msg":"trace[1254433644] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"174.759741ms","start":"2026-02-25T19:27:00.478999Z","end":"2026-02-25T19:27:00.653759Z","steps":["trace[1254433644] 'process raft request'  (duration: 174.491574ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.6539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.487895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.653944Z","caller":"traceutil/trace.go:171","msg":"trace[1646482586] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"169.564476ms","start":"2026-02-25T19:27:00.484366Z","end":"2026-02-25T19:27:00.653931Z","steps":["trace[1646482586] 'agreement among raft nodes before linearized reading'  (duration: 169.470573ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.653945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.143137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.653981Z","caller":"traceutil/trace.go:171","msg":"trace[1013752607] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"161.557513ms","start":"2026-02-25T19:27:00.492384Z","end":"2026-02-25T19:27:00.653941Z","steps":["trace[1013752607] 'process raft request'  (duration: 161.155502ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:00.654031Z","caller":"traceutil/trace.go:171","msg":"trace[1475704557] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"168.252901ms","start":"2026-02-25T19:27:00.485753Z","end":"2026-02-25T19:27:00.654006Z","steps":["trace[1475704557] 'agreement among raft nodes before linearized reading'  (duration: 168.083415ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:00.653816Z","caller":"traceutil/trace.go:171","msg":"trace[901831059] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"167.471367ms","start":"2026-02-25T19:27:00.486323Z","end":"2026-02-25T19:27:00.653794Z","steps":["trace[901831059] 'read index received'  (duration: 105.74717ms)","trace[901831059] 'applied index is now lower than readState.Index'  (duration: 61.720487ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:27:00.65412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.863028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.654151Z","caller":"traceutil/trace.go:171","msg":"trace[549764675] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"168.903609ms","start":"2026-02-25T19:27:00.48524Z","end":"2026-02-25T19:27:00.654143Z","steps":["trace[549764675] 'agreement among raft nodes before linearized reading'  (duration: 168.861288ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.65417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.395386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:27:00.654211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.069114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.65421Z","caller":"traceutil/trace.go:171","msg":"trace[401617319] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"167.447808ms","start":"2026-02-25T19:27:00.48675Z","end":"2026-02-25T19:27:00.654198Z","steps":["trace[401617319] 'agreement among raft nodes before linearized reading'  (duration: 167.383607ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:00.654228Z","caller":"traceutil/trace.go:171","msg":"trace[1073836176] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"169.102485ms","start":"2026-02-25T19:27:00.48512Z","end":"2026-02-25T19:27:00.654223Z","steps":["trace[1073836176] 'agreement among raft nodes before linearized reading'  (duration: 169.078054ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.654249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.354143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.654298Z","caller":"traceutil/trace.go:171","msg":"trace[1727532141] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"168.494098ms","start":"2026-02-25T19:27:00.485786Z","end":"2026-02-25T19:27:00.65428Z","steps":["trace[1727532141] 'agreement among raft nodes before linearized reading'  (duration: 168.417056ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.65439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.484216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.654425Z","caller":"traceutil/trace.go:171","msg":"trace[735740167] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"168.534108ms","start":"2026-02-25T19:27:00.485883Z","end":"2026-02-25T19:27:00.654418Z","steps":["trace[735740167] 'agreement among raft nodes before linearized reading'  (duration: 168.476997ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:00.654038Z","caller":"traceutil/trace.go:171","msg":"trace[1045949768] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"176.115929ms","start":"2026-02-25T19:27:00.47789Z","end":"2026-02-25T19:27:00.654006Z","steps":["trace[1045949768] 'process raft request'  (duration: 114.081813ms)","trace[1045949768] 'compare'  (duration: 61.377577ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:27:00.654435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.014742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.654476Z","caller":"traceutil/trace.go:171","msg":"trace[144072901] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"132.096555ms","start":"2026-02-25T19:27:00.52237Z","end":"2026-02-25T19:27:00.654467Z","steps":["trace[144072901] 'agreement among raft nodes before linearized reading'  (duration: 132.043883ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.654495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.875479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.654522Z","caller":"traceutil/trace.go:171","msg":"trace[1885412894] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"163.91766ms","start":"2026-02-25T19:27:00.490597Z","end":"2026-02-25T19:27:00.654515Z","steps":["trace[1885412894] 'agreement among raft nodes before linearized reading'  (duration: 163.882689ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:00.654583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.23485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:27:00.654608Z","caller":"traceutil/trace.go:171","msg":"trace[366768074] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:622; }","duration":"159.284882ms","start":"2026-02-25T19:27:00.495317Z","end":"2026-02-25T19:27:00.654602Z","steps":["trace[366768074] 'agreement among raft nodes before linearized reading'  (duration: 159.250351ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.176687Z","caller":"traceutil/trace.go:171","msg":"trace[1569633222] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"290.106397ms","start":"2026-02-25T19:27:00.886546Z","end":"2026-02-25T19:27:01.176653Z","steps":["trace[1569633222] 'process raft request'  (duration: 288.782791ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.246918Z","caller":"traceutil/trace.go:171","msg":"trace[795013324] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"163.576111ms","start":"2026-02-25T19:27:01.083318Z","end":"2026-02-25T19:27:01.246894Z","steps":["trace[795013324] 'process raft request'  (duration: 163.468108ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.350537Z","caller":"traceutil/trace.go:171","msg":"trace[1246115189] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"168.832696ms","start":"2026-02-25T19:27:01.181678Z","end":"2026-02-25T19:27:01.35051Z","steps":["trace[1246115189] 'process raft request'  (duration: 99.199796ms)","trace[1246115189] 'compare'  (duration: 69.425654ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:27:01.350677Z","caller":"traceutil/trace.go:171","msg":"trace[1457957071] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"158.408488ms","start":"2026-02-25T19:27:01.19226Z","end":"2026-02-25T19:27:01.350668Z","steps":["trace[1457957071] 'process raft request'  (duration: 158.138921ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.350699Z","caller":"traceutil/trace.go:171","msg":"trace[632218275] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"100.05995ms","start":"2026-02-25T19:27:01.250629Z","end":"2026-02-25T19:27:01.350689Z","steps":["trace[632218275] 'process raft request'  (duration: 99.819433ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.505881Z","caller":"traceutil/trace.go:171","msg":"trace[769811087] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"141.900994ms","start":"2026-02-25T19:27:01.363956Z","end":"2026-02-25T19:27:01.505857Z","steps":["trace[769811087] 'process raft request'  (duration: 133.061009ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.506218Z","caller":"traceutil/trace.go:171","msg":"trace[1214008970] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"141.262006ms","start":"2026-02-25T19:27:01.364945Z","end":"2026-02-25T19:27:01.506207Z","steps":["trace[1214008970] 'process raft request'  (duration: 140.820964ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.588325Z","caller":"traceutil/trace.go:171","msg":"trace[1523328367] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"105.16127ms","start":"2026-02-25T19:27:01.483144Z","end":"2026-02-25T19:27:01.588306Z","steps":["trace[1523328367] 'process raft request'  (duration: 104.594635ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.783177Z","caller":"traceutil/trace.go:171","msg":"trace[1406123460] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"116.474953ms","start":"2026-02-25T19:27:01.666659Z","end":"2026-02-25T19:27:01.783134Z","steps":["trace[1406123460] 'process raft request'  (duration: 108.75286ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:01.783301Z","caller":"traceutil/trace.go:171","msg":"trace[1554140860] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"101.224083ms","start":"2026-02-25T19:27:01.682044Z","end":"2026-02-25T19:27:01.783268Z","steps":["trace[1554140860] 'process raft request'  (duration: 100.976136ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:02.524484Z","caller":"traceutil/trace.go:171","msg":"trace[49474216] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"164.187909ms","start":"2026-02-25T19:27:02.360263Z","end":"2026-02-25T19:27:02.524451Z","steps":["trace[49474216] 'process raft request'  (duration: 107.797837ms)","trace[49474216] 'compare'  (duration: 56.229527ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:27:02.526677Z","caller":"traceutil/trace.go:171","msg":"trace[9087340] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"101.908296ms","start":"2026-02-25T19:27:02.424758Z","end":"2026-02-25T19:27:02.526666Z","steps":["trace[9087340] 'process raft request'  (duration: 101.729032ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:02.777417Z","caller":"traceutil/trace.go:171","msg":"trace[2115337402] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"178.019988ms","start":"2026-02-25T19:27:02.599363Z","end":"2026-02-25T19:27:02.777383Z","steps":["trace[2115337402] 'process raft request'  (duration: 88.529162ms)","trace[2115337402] 'compare'  (duration: 89.27589ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:27:02.777938Z","caller":"traceutil/trace.go:171","msg":"trace[1074593230] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"112.462685ms","start":"2026-02-25T19:27:02.665462Z","end":"2026-02-25T19:27:02.777925Z","steps":["trace[1074593230] 'process raft request'  (duration: 112.019453ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:02.778127Z","caller":"traceutil/trace.go:171","msg":"trace[1217335930] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:690; }","duration":"117.708978ms","start":"2026-02-25T19:27:02.660409Z","end":"2026-02-25T19:27:02.778118Z","steps":["trace[1217335930] 'read index received'  (duration: 27.568344ms)","trace[1217335930] 'applied index is now lower than readState.Index'  (duration: 90.139724ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:27:02.778301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.802921ms","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-25T19:27:02.778337Z","caller":"traceutil/trace.go:171","msg":"trace[73898414] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:666; }","duration":"117.860523ms","start":"2026-02-25T19:27:02.660468Z","end":"2026-02-25T19:27:02.778328Z","steps":["trace[73898414] 'agreement among raft nodes before linearized reading'  (duration: 117.73299ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:02.77835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.624896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T19:27:02.778415Z","caller":"traceutil/trace.go:171","msg":"trace[1928415566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:666; }","duration":"117.703059ms","start":"2026-02-25T19:27:02.660694Z","end":"2026-02-25T19:27:02.778397Z","steps":["trace[1928415566] 'agreement among raft nodes before linearized reading'  (duration: 117.527174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:02.778615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.191562ms","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-25T19:27:02.778699Z","caller":"traceutil/trace.go:171","msg":"trace[1647076469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:666; }","duration":"118.313615ms","start":"2026-02-25T19:27:02.660367Z","end":"2026-02-25T19:27:02.778681Z","steps":["trace[1647076469] 'agreement among raft nodes before linearized reading'  (duration: 117.810021ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:03.50453Z","caller":"traceutil/trace.go:171","msg":"trace[1506220752] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"151.417616ms","start":"2026-02-25T19:27:03.35308Z","end":"2026-02-25T19:27:03.504498Z","steps":["trace[1506220752] 'process raft request'  (duration: 149.169015ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:04.304572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.397386ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648037278 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-jq9b8.189793ecd0069b48\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-jq9b8.189793ecd0069b48\" value_size:640 lease:6507310680793261360 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:27:04.304654Z","caller":"traceutil/trace.go:171","msg":"trace[632777059] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"423.823593ms","start":"2026-02-25T19:27:03.880817Z","end":"2026-02-25T19:27:04.30464Z","steps":["trace[632777059] 'read index received'  (duration: 53.191µs)","trace[632777059] 'applied index is now lower than readState.Index'  (duration: 423.768942ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:27:04.304716Z","caller":"traceutil/trace.go:171","msg":"trace[2091992968] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"596.845894ms","start":"2026-02-25T19:27:03.707863Z","end":"2026-02-25T19:27:04.304709Z","steps":["trace[2091992968] 'process raft request'  (duration: 102.239202ms)","trace[2091992968] 'compare'  (duration: 494.240792ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:27:04.304757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:27:03.707842Z","time spent":"596.897465ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-jq9b8.189793ecd0069b48\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-jq9b8.189793ecd0069b48\" value_size:640 lease:6507310680793261360 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:27:04.304987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.180703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"}
{"level":"info","ts":"2026-02-25T19:27:04.305016Z","caller":"traceutil/trace.go:171","msg":"trace[898500860] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:679; }","duration":"424.248765ms","start":"2026-02-25T19:27:03.880759Z","end":"2026-02-25T19:27:04.305008Z","steps":["trace[898500860] 'agreement among raft nodes before linearized reading'  (duration: 424.113541ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:04.305038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:27:03.880736Z","time spent":"424.296676ms","remote":"127.0.0.1:60426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "}
{"level":"warn","ts":"2026-02-25T19:27:04.305038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.117846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"info","ts":"2026-02-25T19:27:04.305117Z","caller":"traceutil/trace.go:171","msg":"trace[1809847112] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:679; }","duration":"224.206218ms","start":"2026-02-25T19:27:04.080893Z","end":"2026-02-25T19:27:04.305099Z","steps":["trace[1809847112] 'agreement among raft nodes before linearized reading'  (duration: 224.000133ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:07.204056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.610029ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648037345 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:685 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:27:07.204222Z","caller":"traceutil/trace.go:171","msg":"trace[834062052] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"254.320053ms","start":"2026-02-25T19:27:06.949881Z","end":"2026-02-25T19:27:07.204201Z","steps":["trace[834062052] 'process raft request'  (duration: 113.481068ms)","trace[834062052] 'compare'  (duration: 140.513266ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:27:13.34863Z","caller":"traceutil/trace.go:171","msg":"trace[1783228181] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"112.789608ms","start":"2026-02-25T19:27:13.23582Z","end":"2026-02-25T19:27:13.34861Z","steps":["trace[1783228181] 'process raft request'  (duration: 112.685806ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:19.570547Z","caller":"traceutil/trace.go:171","msg":"trace[474270569] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"135.607807ms","start":"2026-02-25T19:27:19.434916Z","end":"2026-02-25T19:27:19.570523Z","steps":["trace[474270569] 'process raft request'  (duration: 135.449184ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:27:26.805496Z","caller":"traceutil/trace.go:171","msg":"trace[665271604] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"163.117181ms","start":"2026-02-25T19:27:26.642352Z","end":"2026-02-25T19:27:26.805469Z","steps":["trace[665271604] 'process raft request'  (duration: 162.919487ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:27:29.281276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.038357ms","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-25T19:27:29.281386Z","caller":"traceutil/trace.go:171","msg":"trace[2049871477] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:836; }","duration":"111.188622ms","start":"2026-02-25T19:27:29.17017Z","end":"2026-02-25T19:27:29.281359Z","steps":["trace[2049871477] 'range keys from in-memory index tree'  (duration: 110.865714ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:13.257208Z","caller":"traceutil/trace.go:171","msg":"trace[421222194] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"254.020819ms","start":"2026-02-25T19:28:13.003157Z","end":"2026-02-25T19:28:13.257178Z","steps":["trace[421222194] 'process raft request'  (duration: 253.799624ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:21.444843Z","caller":"traceutil/trace.go:171","msg":"trace[919741460] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"144.586912ms","start":"2026-02-25T19:28:21.300228Z","end":"2026-02-25T19:28:21.444815Z","steps":["trace[919741460] 'process raft request'  (duration: 144.42764ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:22.015865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.607519ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648038162 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1013 > 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-25T19:28:22.016724Z","caller":"traceutil/trace.go:171","msg":"trace[70456968] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"540.745297ms","start":"2026-02-25T19:28:21.475944Z","end":"2026-02-25T19:28:22.01669Z","steps":["trace[70456968] 'process raft request'  (duration: 158.240053ms)","trace[70456968] 'compare'  (duration: 381.264164ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:28:22.016907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:28:21.47592Z","time spent":"540.896769ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1013 > 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-25T19:28:22.076624Z","caller":"traceutil/trace.go:171","msg":"trace[1703836343] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1065; }","duration":"495.279809ms","start":"2026-02-25T19:28:21.581309Z","end":"2026-02-25T19:28:22.076589Z","steps":["trace[1703836343] 'read index received'  (duration: 52.829319ms)","trace[1703836343] 'applied index is now lower than readState.Index'  (duration: 442.44876ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:28:22.076901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.593169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-25T19:28:22.076975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.896952ms","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-25T19:28:22.07697Z","caller":"traceutil/trace.go:171","msg":"trace[583452807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1020; }","duration":"405.692532ms","start":"2026-02-25T19:28:21.671261Z","end":"2026-02-25T19:28:22.076953Z","steps":["trace[583452807] 'agreement among raft nodes before linearized reading'  (duration: 405.536859ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:22.077012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.521756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-02-25T19:28:22.077031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:28:21.671241Z","time spent":"405.781723ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:28:22.076997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.504112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:28:22.077031Z","caller":"traceutil/trace.go:171","msg":"trace[1048553274] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1020; }","duration":"120.017265ms","start":"2026-02-25T19:28:21.956996Z","end":"2026-02-25T19:28:22.077013Z","steps":["trace[1048553274] 'agreement among raft nodes before linearized reading'  (duration: 119.808601ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:22.077075Z","caller":"traceutil/trace.go:171","msg":"trace[1728785512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1020; }","duration":"311.629648ms","start":"2026-02-25T19:28:21.765426Z","end":"2026-02-25T19:28:22.077056Z","steps":["trace[1728785512] 'agreement among raft nodes before linearized reading'  (duration: 311.449435ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:22.077108Z","caller":"traceutil/trace.go:171","msg":"trace[621656716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1020; }","duration":"495.816127ms","start":"2026-02-25T19:28:21.581268Z","end":"2026-02-25T19:28:22.077084Z","steps":["trace[621656716] 'agreement among raft nodes before linearized reading'  (duration: 495.482581ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:22.077122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:28:21.765406Z","time spent":"311.703729ms","remote":"127.0.0.1:60626","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-25T19:28:22.077152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:28:21.581247Z","time spent":"495.892519ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:28:30.197685Z","caller":"traceutil/trace.go:171","msg":"trace[1449482571] linearizableReadLoop","detail":"{readStateIndex:1095; appliedIndex:1094; }","duration":"121.587027ms","start":"2026-02-25T19:28:30.076072Z","end":"2026-02-25T19:28:30.197659Z","steps":["trace[1449482571] 'read index received'  (duration: 121.388484ms)","trace[1449482571] 'applied index is now lower than readState.Index'  (duration: 197.623µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:28:30.197776Z","caller":"traceutil/trace.go:171","msg":"trace[1300612750] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"139.455658ms","start":"2026-02-25T19:28:30.058282Z","end":"2026-02-25T19:28:30.197738Z","steps":["trace[1300612750] 'process raft request'  (duration: 139.231345ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:30.197864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.7701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:namespace-controller\" ","response":"range_response_count:1 size:725"}
{"level":"info","ts":"2026-02-25T19:28:30.197924Z","caller":"traceutil/trace.go:171","msg":"trace[2001383231] range","detail":"{range_begin:/registry/clusterroles/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1047; }","duration":"121.869502ms","start":"2026-02-25T19:28:30.076023Z","end":"2026-02-25T19:28:30.197892Z","steps":["trace[2001383231] 'agreement among raft nodes before linearized reading'  (duration: 121.77555ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:31.796009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.979991ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730682717648038414 > lease_revoke:<id:5a4e9c9643c9a8dd>","response":"size:28"}
{"level":"info","ts":"2026-02-25T19:28:31.796119Z","caller":"traceutil/trace.go:171","msg":"trace[2115272807] linearizableReadLoop","detail":"{readStateIndex:1100; appliedIndex:1099; }","duration":"173.334988ms","start":"2026-02-25T19:28:31.622764Z","end":"2026-02-25T19:28:31.796099Z","steps":["trace[2115272807] 'read index received'  (duration: 55.232304ms)","trace[2115272807] 'applied index is now lower than readState.Index'  (duration: 118.101144ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:28:31.796282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.210308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-controller\" ","response":"range_response_count:1 size:724"}
{"level":"info","ts":"2026-02-25T19:28:31.79633Z","caller":"traceutil/trace.go:171","msg":"trace[2108691442] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-controller; range_end:; response_count:1; response_revision:1051; }","duration":"157.291078ms","start":"2026-02-25T19:28:31.639022Z","end":"2026-02-25T19:28:31.796313Z","steps":["trace[2108691442] 'agreement among raft nodes before linearized reading'  (duration: 157.187617ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:31.796332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.544731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:677"}
{"level":"info","ts":"2026-02-25T19:28:31.79643Z","caller":"traceutil/trace.go:171","msg":"trace[110921711] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1051; }","duration":"173.696265ms","start":"2026-02-25T19:28:31.622711Z","end":"2026-02-25T19:28:31.796407Z","steps":["trace[110921711] 'agreement among raft nodes before linearized reading'  (duration: 173.484311ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:32.442342Z","caller":"traceutil/trace.go:171","msg":"trace[591047899] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"155.312658ms","start":"2026-02-25T19:28:32.287013Z","end":"2026-02-25T19:28:32.442326Z","steps":["trace[591047899] 'process raft request'  (duration: 155.284647ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:32.442401Z","caller":"traceutil/trace.go:171","msg":"trace[44401939] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"155.359598ms","start":"2026-02-25T19:28:32.287011Z","end":"2026-02-25T19:28:32.44237Z","steps":["trace[44401939] 'process raft request'  (duration: 155.182836ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:32.464003Z","caller":"traceutil/trace.go:171","msg":"trace[894257249] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1101; }","duration":"126.953601ms","start":"2026-02-25T19:28:32.337028Z","end":"2026-02-25T19:28:32.463981Z","steps":["trace[894257249] 'read index received'  (duration: 105.190239ms)","trace[894257249] 'applied index is now lower than readState.Index'  (duration: 21.762201ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:28:32.464074Z","caller":"traceutil/trace.go:171","msg":"trace[1597843849] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"177.007078ms","start":"2026-02-25T19:28:32.287042Z","end":"2026-02-25T19:28:32.464049Z","steps":["trace[1597843849] 'process raft request'  (duration: 176.827325ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:32.46421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.165404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:coredns\" ","response":"range_response_count:1 size:388"}
{"level":"info","ts":"2026-02-25T19:28:32.464259Z","caller":"traceutil/trace.go:171","msg":"trace[1999518894] range","detail":"{range_begin:/registry/clusterroles/system:coredns; range_end:; response_count:1; response_revision:1055; }","duration":"127.253346ms","start":"2026-02-25T19:28:32.336993Z","end":"2026-02-25T19:28:32.464247Z","steps":["trace[1999518894] 'agreement among raft nodes before linearized reading'  (duration: 127.133074ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:32.464458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.898477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-02-25T19:28:32.464523Z","caller":"traceutil/trace.go:171","msg":"trace[107325103] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:1; response_revision:1055; }","duration":"119.990708ms","start":"2026-02-25T19:28:32.344518Z","end":"2026-02-25T19:28:32.464509Z","steps":["trace[107325103] 'agreement among raft nodes before linearized reading'  (duration: 119.843886ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:32.735117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.071911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-25T19:28:32.73518Z","caller":"traceutil/trace.go:171","msg":"trace[1894614037] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-proxier; range_end:; response_count:1; response_revision:1055; }","duration":"187.164633ms","start":"2026-02-25T19:28:32.548Z","end":"2026-02-25T19:28:32.735165Z","steps":["trace[1894614037] 'range keys from in-memory index tree'  (duration: 186.933559ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:32.735206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.265951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:28:32.735302Z","caller":"traceutil/trace.go:171","msg":"trace[1689039481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1055; }","duration":"154.427514ms","start":"2026-02-25T19:28:32.580853Z","end":"2026-02-25T19:28:32.73528Z","steps":["trace[1689039481] 'range keys from in-memory index tree'  (duration: 154.17226ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:28:32.735523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.915145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-02-25T19:28:32.735612Z","caller":"traceutil/trace.go:171","msg":"trace[893089560] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:1; response_revision:1055; }","duration":"193.149069ms","start":"2026-02-25T19:28:32.54244Z","end":"2026-02-25T19:28:32.735589Z","steps":["trace[893089560] 'range keys from in-memory index tree'  (duration: 192.538589ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:28:33.743592Z","caller":"traceutil/trace.go:171","msg":"trace[770466979] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1105; }","duration":"120.400698ms","start":"2026-02-25T19:28:33.623165Z","end":"2026-02-25T19:28:33.743566Z","steps":["trace[770466979] 'read index received'  (duration: 95.434166ms)","trace[770466979] 'applied index is now lower than readState.Index'  (duration: 24.965322ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:28:33.743725Z","caller":"traceutil/trace.go:171","msg":"trace[1999009582] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"126.623699ms","start":"2026-02-25T19:28:33.617068Z","end":"2026-02-25T19:28:33.743691Z","steps":["trace[1999009582] 'process raft request'  (duration: 101.507735ms)","trace[1999009582] 'compare'  (duration: 24.86513ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:28:33.743805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.619581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kubelet-api-admin\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-02-25T19:28:33.743841Z","caller":"traceutil/trace.go:171","msg":"trace[1455733323] range","detail":"{range_begin:/registry/clusterroles/system:kubelet-api-admin; range_end:; response_count:1; response_revision:1057; }","duration":"120.693942ms","start":"2026-02-25T19:28:33.623136Z","end":"2026-02-25T19:28:33.74383Z","steps":["trace[1455733323] 'agreement among raft nodes before linearized reading'  (duration: 120.56571ms)"],"step_count":1}