{"level":"warn","ts":"2026-04-07T05:54:49.504787Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T05:54:49.504858Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-04-07T05:54:49.504917Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T05:54:49.504929Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-07T05:54:49.504944Z","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-04-07T05:54:49.50553Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-04-07T05:54:49.505598Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-04-07T05:54:49.514595Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.828871ms"} {"level":"info","ts":"2026-04-07T05:54:49.584961Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-04-07T05:54:49.585081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:54:49.585107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-04-07T05:54:49.585122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:54:49.585138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-04-07T05:54:49.585181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-04-07T05:54:49.60782Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:54:49.609342Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:54:49.610826Z","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-04-07T05:54:49.613073Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:54:49.613244Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:54:49.613482Z","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-04-07T05:54:49.613522Z","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-04-07T05:54:49.613531Z","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-04-07T05:54:49.615007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-04-07T05:54:49.615142Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-07T05:54:49.620153Z","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-04-07T05:54:49.620352Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:54:49.620385Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:54:49.620517Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-07T05:54:49.620535Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-07T05:54:49.985628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:54:49.985691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:54:49.985722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-04-07T05:54:49.985754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:54:49.985769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-07T05:54:49.985789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-04-07T05:54:49.985802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-07T05:54:50.303467Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:54:50.303853Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:54:50.304059Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:54:50.304213Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:54:50.30434Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:54:50.304431Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:54:50.306025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T05:54:50.306107Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-04-07T05:54:50.471675Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:54:50.471925Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:54:50.472091Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T05:54:50.472323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.22901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.472404Z","caller":"traceutil/trace.go:171","msg":"trace[1248730051] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"125.326012ms","start":"2026-04-07T05:54:50.347061Z","end":"2026-04-07T05:54:50.472387Z","steps":["trace[1248730051] 'agreement among raft nodes before linearized reading' (duration: 125.096657ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.472029Z","caller":"traceutil/trace.go:171","msg":"trace[1066860609] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"124.941963ms","start":"2026-04-07T05:54:50.347066Z","end":"2026-04-07T05:54:50.472008Z","steps":["trace[1066860609] 'read index received' (duration: 124.597423ms)","trace[1066860609] 'applied index is now lower than readState.Index' (duration: 336.51µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:54:50.474223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.059158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.474273Z","caller":"traceutil/trace.go:171","msg":"trace[1192626425] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"127.14406ms","start":"2026-04-07T05:54:50.347117Z","end":"2026-04-07T05:54:50.474261Z","steps":["trace[1192626425] 'agreement among raft nodes before linearized reading' (duration: 125.974199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.071412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.75656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968164Z","caller":"traceutil/trace.go:171","msg":"trace[482177053] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"398.149604ms","start":"2026-04-07T05:54:50.569989Z","end":"2026-04-07T05:54:50.968139Z","steps":["trace[482177053] 'range keys from in-memory index tree' (duration: 397.95804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.972712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.313042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.774069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.298057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.332702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.264963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968494Z","caller":"traceutil/trace.go:171","msg":"trace[1396415989] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"237.41829ms","start":"2026-04-07T05:54:50.731038Z","end":"2026-04-07T05:54:50.968456Z","steps":["trace[1396415989] 'count revisions from in-memory index tree' (duration: 237.188364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.618111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.325404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968581Z","caller":"traceutil/trace.go:171","msg":"trace[898291200] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"190.365946ms","start":"2026-04-07T05:54:50.778206Z","end":"2026-04-07T05:54:50.968572Z","steps":["trace[898291200] 'range keys from in-memory index tree' (duration: 190.247922ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.968574Z","caller":"traceutil/trace.go:171","msg":"trace[725859853] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"286.712264ms","start":"2026-04-07T05:54:50.681846Z","end":"2026-04-07T05:54:50.968558Z","steps":["trace[725859853] 'range keys from in-memory index tree' (duration: 286.54194ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.968523Z","caller":"traceutil/trace.go:171","msg":"trace[658579088] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"274.384123ms","start":"2026-04-07T05:54:50.694111Z","end":"2026-04-07T05:54:50.968495Z","steps":["trace[658579088] 'range keys from in-memory index tree' (duration: 274.207539ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.968401Z","caller":"traceutil/trace.go:171","msg":"trace[1232113385] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"435.276461ms","start":"2026-04-07T05:54:50.533113Z","end":"2026-04-07T05:54:50.96839Z","steps":["trace[1232113385] 'range keys from in-memory index tree' (duration: 434.944332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.817304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968753Z","caller":"traceutil/trace.go:171","msg":"trace[1339243497] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"226.880746ms","start":"2026-04-07T05:54:50.741862Z","end":"2026-04-07T05:54:50.968742Z","steps":["trace[1339243497] 'range keys from in-memory index tree' (duration: 226.764983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.323145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.362697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968808Z","caller":"traceutil/trace.go:171","msg":"trace[1095142789] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"104.389767ms","start":"2026-04-07T05:54:50.864408Z","end":"2026-04-07T05:54:50.968797Z","steps":["trace[1095142789] 'count revisions from in-memory index tree' (duration: 104.296444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.435977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968806Z","caller":"traceutil/trace.go:171","msg":"trace[538291947] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"119.497741ms","start":"2026-04-07T05:54:50.849293Z","end":"2026-04-07T05:54:50.96879Z","steps":["trace[538291947] 'range keys from in-memory index tree' (duration: 119.164922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.611958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968875Z","caller":"traceutil/trace.go:171","msg":"trace[1558518727] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"226.644259ms","start":"2026-04-07T05:54:50.742225Z","end":"2026-04-07T05:54:50.968869Z","steps":["trace[1558518727] 'count revisions from in-memory index tree' (duration: 226.571007ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.968869Z","caller":"traceutil/trace.go:171","msg":"trace[592843340] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"301.791756ms","start":"2026-04-07T05:54:50.667059Z","end":"2026-04-07T05:54:50.968851Z","steps":["trace[592843340] 'count revisions from in-memory index tree' (duration: 301.397546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.667051Z","time spent":"301.852387ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":27,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.968954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.478357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.968971Z","caller":"traceutil/trace.go:171","msg":"trace[963563407] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"213.507047ms","start":"2026-04-07T05:54:50.755459Z","end":"2026-04-07T05:54:50.968966Z","steps":["trace[963563407] 'range keys from in-memory index tree' (duration: 213.442725ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.96896Z","caller":"traceutil/trace.go:171","msg":"trace[1036227404] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"301.367755ms","start":"2026-04-07T05:54:50.667133Z","end":"2026-04-07T05:54:50.968501Z","steps":["trace[1036227404] 'range keys from in-memory index tree' (duration: 301.125958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.969012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.667105Z","time spent":"301.896868ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":27,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.969061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.415615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.96908Z","caller":"traceutil/trace.go:171","msg":"trace[194240792] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"213.465227ms","start":"2026-04-07T05:54:50.75561Z","end":"2026-04-07T05:54:50.969075Z","steps":["trace[194240792] 'count revisions from in-memory index tree' (duration: 213.296462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.569976Z","time spent":"398.248506ms","remote":"127.0.0.1:45936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.96916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.512642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969177Z","caller":"traceutil/trace.go:171","msg":"trace[1958081083] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"202.559793ms","start":"2026-04-07T05:54:50.766613Z","end":"2026-04-07T05:54:50.969172Z","steps":["trace[1958081083] 'count revisions from in-memory index tree' (duration: 202.462341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.969195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.761357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.96928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.090783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.348746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969303Z","caller":"traceutil/trace.go:171","msg":"trace[489243686] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"172.918581ms","start":"2026-04-07T05:54:50.796374Z","end":"2026-04-07T05:54:50.969292Z","steps":["trace[489243686] 'count revisions from in-memory index tree' (duration: 172.714326ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.96933Z","caller":"traceutil/trace.go:171","msg":"trace[223100390] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"119.994413ms","start":"2026-04-07T05:54:50.84933Z","end":"2026-04-07T05:54:50.969324Z","steps":["trace[223100390] 'count revisions from in-memory index tree' (duration: 119.261294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.75346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.969363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.38309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969383Z","caller":"traceutil/trace.go:171","msg":"trace[1407436116] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"262.427041ms","start":"2026-04-07T05:54:50.706951Z","end":"2026-04-07T05:54:50.969378Z","steps":["trace[1407436116] 'range keys from in-memory index tree' (duration: 262.282908ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.969375Z","caller":"traceutil/trace.go:171","msg":"trace[1286458526] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"326.861679ms","start":"2026-04-07T05:54:50.642499Z","end":"2026-04-07T05:54:50.969361Z","steps":["trace[1286458526] 'count revisions from in-memory index tree' (duration: 325.666947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.96875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.436369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969419Z","caller":"traceutil/trace.go:171","msg":"trace[26176287] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1; }","duration":"105.121726ms","start":"2026-04-07T05:54:50.864292Z","end":"2026-04-07T05:54:50.969414Z","steps":["trace[26176287] 'range keys from in-memory index tree' (duration: 104.376377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.969427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.642469Z","time spent":"326.94386ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.969481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.208884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969543Z","caller":"traceutil/trace.go:171","msg":"trace[234036380] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"275.301196ms","start":"2026-04-07T05:54:50.694235Z","end":"2026-04-07T05:54:50.969536Z","steps":["trace[234036380] 'count revisions from in-memory index tree' (duration: 275.134662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.969264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.548043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969577Z","caller":"traceutil/trace.go:171","msg":"trace[2040744602] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"202.999664ms","start":"2026-04-07T05:54:50.766572Z","end":"2026-04-07T05:54:50.969572Z","steps":["trace[2040744602] 'range keys from in-memory index tree' (duration: 202.514511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.969593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.080735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.96963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.657746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.351403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969648Z","caller":"traceutil/trace.go:171","msg":"trace[1093919312] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"262.715628ms","start":"2026-04-07T05:54:50.706926Z","end":"2026-04-07T05:54:50.969642Z","steps":["trace[1093919312] 'count revisions from in-memory index tree' (duration: 262.566474ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.969665Z","caller":"traceutil/trace.go:171","msg":"trace[2013171380] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"315.688847ms","start":"2026-04-07T05:54:50.653969Z","end":"2026-04-07T05:54:50.969658Z","steps":["trace[2013171380] 'range keys from in-memory index tree' (duration: 314.314212ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.969635Z","caller":"traceutil/trace.go:171","msg":"trace[2114516781] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"173.152917ms","start":"2026-04-07T05:54:50.796473Z","end":"2026-04-07T05:54:50.969626Z","steps":["trace[2114516781] 'range keys from in-memory index tree' (duration: 173.011054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.96969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.653961Z","time spent":"315.719038ms","remote":"127.0.0.1:45968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.96883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.533106Z","time spent":"435.710142ms","remote":"127.0.0.1:45930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.968336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.286508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.969862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.633586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.969851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.298957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.969337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.770515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.970003Z","caller":"traceutil/trace.go:171","msg":"trace[954161717] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"365.438292ms","start":"2026-04-07T05:54:50.604542Z","end":"2026-04-07T05:54:50.96998Z","steps":["trace[954161717] 'range keys from in-memory index tree' (duration: 364.670892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.970051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.427256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.970069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.604529Z","time spent":"365.520535ms","remote":"127.0.0.1:45938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 "} {"level":"info","ts":"2026-04-07T05:54:50.970119Z","caller":"traceutil/trace.go:171","msg":"trace[1988636263] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"145.469687ms","start":"2026-04-07T05:54:50.824605Z","end":"2026-04-07T05:54:50.970075Z","steps":["trace[1988636263] 'count revisions from in-memory index tree' (duration: 145.368305ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.970198Z","caller":"traceutil/trace.go:171","msg":"trace[1081776770] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"363.825641ms","start":"2026-04-07T05:54:50.604605Z","end":"2026-04-07T05:54:50.968431Z","steps":["trace[1081776770] 'count revisions from in-memory index tree' (duration: 363.742229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.123433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.97028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.101073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.970292Z","caller":"traceutil/trace.go:171","msg":"trace[1703790543] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"239.436453ms","start":"2026-04-07T05:54:50.730848Z","end":"2026-04-07T05:54:50.970285Z","steps":["trace[1703790543] 'range keys from in-memory index tree' (duration: 237.065802ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.970303Z","caller":"traceutil/trace.go:171","msg":"trace[1301084065] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"423.143724ms","start":"2026-04-07T05:54:50.547154Z","end":"2026-04-07T05:54:50.970298Z","steps":["trace[1301084065] 'count revisions from in-memory index tree' (duration: 423.061762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.970329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.547144Z","time spent":"423.173586ms","remote":"127.0.0.1:45932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.970244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.604599Z","time spent":"365.633257ms","remote":"127.0.0.1:45938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-07T05:54:50.9699Z","caller":"traceutil/trace.go:171","msg":"trace[1779677656] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"252.703198ms","start":"2026-04-07T05:54:50.71719Z","end":"2026-04-07T05:54:50.969893Z","steps":["trace[1779677656] 'range keys from in-memory index tree' (duration: 252.514043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.970432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.280453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.970454Z","caller":"traceutil/trace.go:171","msg":"trace[1923759591] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"437.329145ms","start":"2026-04-07T05:54:50.53312Z","end":"2026-04-07T05:54:50.970449Z","steps":["trace[1923759591] 'count revisions from in-memory index tree' (duration: 437.220001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.703735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.970473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.533105Z","time spent":"437.362035ms","remote":"127.0.0.1:45930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-04-07T05:54:50.970478Z","caller":"traceutil/trace.go:171","msg":"trace[1314890561] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"344.186029ms","start":"2026-04-07T05:54:50.626285Z","end":"2026-04-07T05:54:50.970471Z","steps":["trace[1314890561] 'range keys from in-memory index tree' (duration: 341.664854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.895407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.96999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.371348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.968045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.621457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:54:50.970581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.371941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.970581Z","caller":"traceutil/trace.go:171","msg":"trace[571276372] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"411.211155ms","start":"2026-04-07T05:54:50.559364Z","end":"2026-04-07T05:54:50.970575Z","steps":["trace[571276372] 'count revisions from in-memory index tree' (duration: 408.564675ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.970579Z","caller":"traceutil/trace.go:171","msg":"trace[169634009] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"159.973575ms","start":"2026-04-07T05:54:50.810591Z","end":"2026-04-07T05:54:50.970564Z","steps":["trace[169634009] 'range keys from in-memory index tree' (duration: 159.272166ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.9706Z","caller":"traceutil/trace.go:171","msg":"trace[815348484] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"423.391981ms","start":"2026-04-07T05:54:50.547202Z","end":"2026-04-07T05:54:50.970594Z","steps":["trace[815348484] 'range keys from in-memory index tree' (duration: 423.339781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.970615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.559354Z","time spent":"411.249676ms","remote":"127.0.0.1:45934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.97062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.547181Z","time spent":"423.434003ms","remote":"127.0.0.1:45932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.970735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.593242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.970759Z","caller":"traceutil/trace.go:171","msg":"trace[235988646] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"356.617822ms","start":"2026-04-07T05:54:50.614135Z","end":"2026-04-07T05:54:50.970753Z","steps":["trace[235988646] 'range keys from in-memory index tree' (duration: 356.51355ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.969904Z","caller":"traceutil/trace.go:171","msg":"trace[1994292058] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"399.861689ms","start":"2026-04-07T05:54:50.570016Z","end":"2026-04-07T05:54:50.969878Z","steps":["trace[1994292058] 'count revisions from in-memory index tree' (duration: 398.193956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.970828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.61411Z","time spent":"356.661884ms","remote":"127.0.0.1:45950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.970851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.570003Z","time spent":"400.830443ms","remote":"127.0.0.1:45936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.970984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.807777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.969953Z","caller":"traceutil/trace.go:171","msg":"trace[476880176] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"159.41688ms","start":"2026-04-07T05:54:50.810526Z","end":"2026-04-07T05:54:50.969943Z","steps":["trace[476880176] 'count revisions from in-memory index tree' (duration: 159.260836ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.971009Z","caller":"traceutil/trace.go:171","msg":"trace[1818501657] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"132.835378ms","start":"2026-04-07T05:54:50.838168Z","end":"2026-04-07T05:54:50.971003Z","steps":["trace[1818501657] 'count revisions from in-memory index tree' (duration: 132.760786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.971105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.484163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.971126Z","caller":"traceutil/trace.go:171","msg":"trace[2085213884] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"146.533415ms","start":"2026-04-07T05:54:50.824587Z","end":"2026-04-07T05:54:50.971121Z","steps":["trace[2085213884] 'range keys from in-memory index tree' (duration: 146.420052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.970503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.626281Z","time spent":"344.211731ms","remote":"127.0.0.1:45954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.971287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.897219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.97131Z","caller":"traceutil/trace.go:171","msg":"trace[1756281328] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"132.948281ms","start":"2026-04-07T05:54:50.838357Z","end":"2026-04-07T05:54:50.971305Z","steps":["trace[1756281328] 'range keys from in-memory index tree' (duration: 132.822358ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.968231Z","caller":"traceutil/trace.go:171","msg":"trace[738377395] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"325.844301ms","start":"2026-04-07T05:54:50.642314Z","end":"2026-04-07T05:54:50.968158Z","steps":["trace[738377395] 'range keys from in-memory index tree' (duration: 325.667828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.971439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.642298Z","time spent":"329.133658ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 "} {"level":"info","ts":"2026-04-07T05:54:50.969312Z","caller":"traceutil/trace.go:171","msg":"trace[2085499605] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"355.133684ms","start":"2026-04-07T05:54:50.614169Z","end":"2026-04-07T05:54:50.969303Z","steps":["trace[2085499605] 'count revisions from in-memory index tree' (duration: 355.065483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.971679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.614165Z","time spent":"357.495556ms","remote":"127.0.0.1:45950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.969285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.009672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.971848Z","caller":"traceutil/trace.go:171","msg":"trace[2037335551] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"193.570219ms","start":"2026-04-07T05:54:50.778272Z","end":"2026-04-07T05:54:50.971842Z","steps":["trace[2037335551] 'count revisions from in-memory index tree' (duration: 190.990652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.971968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.596628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.972019Z","caller":"traceutil/trace.go:171","msg":"trace[599344543] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"254.671519ms","start":"2026-04-07T05:54:50.717334Z","end":"2026-04-07T05:54:50.972005Z","steps":["trace[599344543] 'count revisions from in-memory index tree' (duration: 254.517446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.968066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.501833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.972158Z","caller":"traceutil/trace.go:171","msg":"trace[1061458939] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"412.59738ms","start":"2026-04-07T05:54:50.559554Z","end":"2026-04-07T05:54:50.972152Z","steps":["trace[1061458939] 'range keys from in-memory index tree' (duration: 408.428421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.972237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.55954Z","time spent":"412.638872ms","remote":"127.0.0.1:45934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.968072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.226992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.97231Z","caller":"traceutil/trace.go:171","msg":"trace[1298113252] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"451.488443ms","start":"2026-04-07T05:54:50.520815Z","end":"2026-04-07T05:54:50.972303Z","steps":["trace[1298113252] 'range keys from in-memory index tree' (duration: 447.179091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.97233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.520801Z","time spent":"451.520984ms","remote":"127.0.0.1:45914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T05:54:50.96807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.813497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.972419Z","caller":"traceutil/trace.go:171","msg":"trace[152286003] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"346.175821ms","start":"2026-04-07T05:54:50.626231Z","end":"2026-04-07T05:54:50.972407Z","steps":["trace[152286003] 'count revisions from in-memory index tree' (duration: 341.720855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.97247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.626224Z","time spent":"346.229592ms","remote":"127.0.0.1:45954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:54:50.968087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.069567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:54:50.972606Z","caller":"traceutil/trace.go:171","msg":"trace[1225625634] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"451.603016ms","start":"2026-04-07T05:54:50.52099Z","end":"2026-04-07T05:54:50.972593Z","steps":["trace[1225625634] 'count revisions from in-memory index tree' (duration: 447.017186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.972637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.520961Z","time spent":"451.665988ms","remote":"127.0.0.1:45914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-04-07T05:54:50.974728Z","caller":"traceutil/trace.go:171","msg":"trace[1757462812] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"292.71825ms","start":"2026-04-07T05:54:50.681994Z","end":"2026-04-07T05:54:50.974712Z","steps":["trace[1757462812] 'count revisions from in-memory index tree' (duration: 286.809455ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:50.972335Z","caller":"traceutil/trace.go:171","msg":"trace[525762321] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"314.387054ms","start":"2026-04-07T05:54:50.654029Z","end":"2026-04-07T05:54:50.968417Z","steps":["trace[525762321] 'count revisions from in-memory index tree' (duration: 314.248961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:50.975808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:50.654005Z","time spent":"321.783375ms","remote":"127.0.0.1:45968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-07T05:55:18.249459Z","caller":"traceutil/trace.go:171","msg":"trace[2115782855] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"187.583467ms","start":"2026-04-07T05:55:18.061859Z","end":"2026-04-07T05:55:18.249442Z","steps":["trace[2115782855] 'process raft request' (duration: 187.481474ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.400887Z","caller":"traceutil/trace.go:171","msg":"trace[1020885900] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"174.861679ms","start":"2026-04-07T05:55:18.225996Z","end":"2026-04-07T05:55:18.400857Z","steps":["trace[1020885900] 'process raft request' (duration: 174.359045ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.401158Z","caller":"traceutil/trace.go:171","msg":"trace[807289478] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"171.056858ms","start":"2026-04-07T05:55:18.230023Z","end":"2026-04-07T05:55:18.40108Z","steps":["trace[807289478] 'process raft request' (duration: 170.618166ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.401366Z","caller":"traceutil/trace.go:171","msg":"trace[1594902488] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"167.909874ms","start":"2026-04-07T05:55:18.233422Z","end":"2026-04-07T05:55:18.401332Z","steps":["trace[1594902488] 'process raft request' (duration: 167.333509ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.401476Z","caller":"traceutil/trace.go:171","msg":"trace[1958575487] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"161.474243ms","start":"2026-04-07T05:55:18.239961Z","end":"2026-04-07T05:55:18.401435Z","steps":["trace[1958575487] 'process raft request' (duration: 161.233047ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.402808Z","caller":"traceutil/trace.go:171","msg":"trace[1728971421] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"161.270878ms","start":"2026-04-07T05:55:18.24152Z","end":"2026-04-07T05:55:18.40279Z","steps":["trace[1728971421] 'process raft request' (duration: 161.210276ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.403142Z","caller":"traceutil/trace.go:171","msg":"trace[1639740588] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"162.526771ms","start":"2026-04-07T05:55:18.2406Z","end":"2026-04-07T05:55:18.403127Z","steps":["trace[1639740588] 'process raft request' (duration: 160.773494ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.407299Z","caller":"traceutil/trace.go:171","msg":"trace[179838652] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:520; }","duration":"107.509509ms","start":"2026-04-07T05:55:18.299771Z","end":"2026-04-07T05:55:18.40728Z","steps":["trace[179838652] 'read index received' (duration: 99.095945ms)","trace[179838652] 'applied index is now lower than readState.Index' (duration: 8.412904ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:55:18.407706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.914369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:55:18.407739Z","caller":"traceutil/trace.go:171","msg":"trace[120457052] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"108.004191ms","start":"2026-04-07T05:55:18.299727Z","end":"2026-04-07T05:55:18.407731Z","steps":["trace[120457052] 'agreement among raft nodes before linearized reading' (duration: 107.634532ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.408152Z","caller":"traceutil/trace.go:171","msg":"trace[637019944] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"153.928752ms","start":"2026-04-07T05:55:18.254213Z","end":"2026-04-07T05:55:18.408142Z","steps":["trace[637019944] 'process raft request' (duration: 152.696909ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.408658Z","caller":"traceutil/trace.go:171","msg":"trace[1941834975] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"104.070747ms","start":"2026-04-07T05:55:18.304572Z","end":"2026-04-07T05:55:18.408642Z","steps":["trace[1941834975] 'process raft request' (duration: 102.613748ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.408768Z","caller":"traceutil/trace.go:171","msg":"trace[516837983] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"150.677046ms","start":"2026-04-07T05:55:18.258085Z","end":"2026-04-07T05:55:18.408762Z","steps":["trace[516837983] 'process raft request' (duration: 148.921909ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.408815Z","caller":"traceutil/trace.go:171","msg":"trace[1672367023] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"147.322587ms","start":"2026-04-07T05:55:18.261487Z","end":"2026-04-07T05:55:18.40881Z","steps":["trace[1672367023] 'process raft request' (duration: 145.55627ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:18.408857Z","caller":"traceutil/trace.go:171","msg":"trace[117219010] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"138.567924ms","start":"2026-04-07T05:55:18.270282Z","end":"2026-04-07T05:55:18.40885Z","steps":["trace[117219010] 'process raft request' (duration: 136.833088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:24.432743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.869124ms","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-04-07T05:55:24.43282Z","caller":"traceutil/trace.go:171","msg":"trace[406396979] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"152.987637ms","start":"2026-04-07T05:55:24.279816Z","end":"2026-04-07T05:55:24.432804Z","steps":["trace[406396979] 'range keys from in-memory index tree' (duration: 152.730711ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:25.140142Z","caller":"traceutil/trace.go:171","msg":"trace[112951843] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"506.610779ms","start":"2026-04-07T05:55:24.633471Z","end":"2026-04-07T05:55:25.140082Z","steps":["trace[112951843] 'process raft request' (duration: 505.915531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:25.140891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:55:24.633445Z","time spent":"506.811205ms","remote":"127.0.0.1:45848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:55:25.693483Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953875782563325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T05:55:25.864358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.01278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:55:25.864557Z","caller":"traceutil/trace.go:171","msg":"trace[1197247564] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:637; }","duration":"671.304588ms","start":"2026-04-07T05:55:25.193237Z","end":"2026-04-07T05:55:25.864542Z","steps":["trace[1197247564] 'read index received' (duration: 545.02485ms)","trace[1197247564] 'applied index is now lower than readState.Index' (duration: 126.278877ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:55:25.864582Z","caller":"traceutil/trace.go:171","msg":"trace[609590935] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"693.192951ms","start":"2026-04-07T05:55:25.171339Z","end":"2026-04-07T05:55:25.864532Z","steps":["trace[609590935] 'process raft request' (duration: 566.812561ms)","trace[609590935] 'compare' (duration: 125.870326ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:55:25.864677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.437982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:55:25.86466Z","caller":"traceutil/trace.go:171","msg":"trace[1593490362] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"244.940332ms","start":"2026-04-07T05:55:25.619695Z","end":"2026-04-07T05:55:25.864636Z","steps":["trace[1593490362] 'process raft request' (duration: 244.806668ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:25.864711Z","caller":"traceutil/trace.go:171","msg":"trace[2051435991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"671.516634ms","start":"2026-04-07T05:55:25.193185Z","end":"2026-04-07T05:55:25.864702Z","steps":["trace[2051435991] 'agreement among raft nodes before linearized reading' (duration: 671.444682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:25.864772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:55:25.171308Z","time spent":"693.345844ms","remote":"127.0.0.1:45930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:55:25.864876Z","caller":"traceutil/trace.go:171","msg":"trace[1801602676] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"660.06138ms","start":"2026-04-07T05:55:25.20452Z","end":"2026-04-07T05:55:25.864581Z","steps":["trace[1801602676] 'process raft request' (duration: 659.937495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:25.864877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.346159ms","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-04-07T05:55:25.865159Z","caller":"traceutil/trace.go:171","msg":"trace[2043006501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"123.670528ms","start":"2026-04-07T05:55:25.741471Z","end":"2026-04-07T05:55:25.865142Z","steps":["trace[2043006501] 'agreement among raft nodes before linearized reading' (duration: 123.259397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:25.865135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:55:25.2045Z","time spent":"660.547011ms","remote":"127.0.0.1:45954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:55:25.864886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:55:25.193164Z","time spent":"671.703778ms","remote":"127.0.0.1:45758","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-04-07T05:55:27.41099Z","caller":"traceutil/trace.go:171","msg":"trace[521493884] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"167.41422ms","start":"2026-04-07T05:55:27.243548Z","end":"2026-04-07T05:55:27.410963Z","steps":["trace[521493884] 'process raft request' (duration: 166.607609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:40.540988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.266459ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:55:40.541121Z","caller":"traceutil/trace.go:171","msg":"trace[363092835] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:772; }","duration":"102.421983ms","start":"2026-04-07T05:55:40.438679Z","end":"2026-04-07T05:55:40.541101Z","steps":["trace[363092835] 'range keys from in-memory index tree' (duration: 102.245519ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:40.759934Z","caller":"traceutil/trace.go:171","msg":"trace[1517599117] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"144.627316ms","start":"2026-04-07T05:55:40.615283Z","end":"2026-04-07T05:55:40.75991Z","steps":["trace[1517599117] 'read index received' (duration: 144.44088ms)","trace[1517599117] 'applied index is now lower than readState.Index' (duration: 185.576µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:55:40.760019Z","caller":"traceutil/trace.go:171","msg":"trace[945999220] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"145.665973ms","start":"2026-04-07T05:55:40.614326Z","end":"2026-04-07T05:55:40.759992Z","steps":["trace[945999220] 'process raft request' (duration: 145.447428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:40.760152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.856321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:55:40.760194Z","caller":"traceutil/trace.go:171","msg":"trace[1791585068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:773; }","duration":"144.951524ms","start":"2026-04-07T05:55:40.615232Z","end":"2026-04-07T05:55:40.760184Z","steps":["trace[1791585068] 'agreement among raft nodes before linearized reading' (duration: 144.774659ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:44.899614Z","caller":"traceutil/trace.go:171","msg":"trace[1177876089] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:846; }","duration":"128.744503ms","start":"2026-04-07T05:55:44.770844Z","end":"2026-04-07T05:55:44.899589Z","steps":["trace[1177876089] 'read index received' (duration: 45.530311ms)","trace[1177876089] 'applied index is now lower than readState.Index' (duration: 83.212782ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:55:44.899768Z","caller":"traceutil/trace.go:171","msg":"trace[478933096] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"140.022823ms","start":"2026-04-07T05:55:44.759707Z","end":"2026-04-07T05:55:44.899729Z","steps":["trace[478933096] 'process raft request' (duration: 115.292635ms)","trace[478933096] 'compare' (duration: 24.473742ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:55:44.899967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.101522ms","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-04-07T05:55:44.900037Z","caller":"traceutil/trace.go:171","msg":"trace[994470218] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:822; }","duration":"129.208915ms","start":"2026-04-07T05:55:44.77081Z","end":"2026-04-07T05:55:44.900019Z","steps":["trace[994470218] 'agreement among raft nodes before linearized reading' (duration: 128.933718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:44.900112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.016762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:55:44.900187Z","caller":"traceutil/trace.go:171","msg":"trace[740418503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:822; }","duration":"102.099425ms","start":"2026-04-07T05:55:44.798039Z","end":"2026-04-07T05:55:44.900138Z","steps":["trace[740418503] 'agreement among raft nodes before linearized reading' (duration: 101.93356ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:53.110356Z","caller":"traceutil/trace.go:171","msg":"trace[2138746718] linearizableReadLoop","detail":"{readStateIndex:930; appliedIndex:929; }","duration":"154.340544ms","start":"2026-04-07T05:55:52.955986Z","end":"2026-04-07T05:55:53.110327Z","steps":["trace[2138746718] 'read index received' (duration: 154.221581ms)","trace[2138746718] 'applied index is now lower than readState.Index' (duration: 117.933µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:55:53.110403Z","caller":"traceutil/trace.go:171","msg":"trace[2083044297] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"164.0154ms","start":"2026-04-07T05:55:52.946358Z","end":"2026-04-07T05:55:53.110374Z","steps":["trace[2083044297] 'process raft request' (duration: 163.815775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:53.110572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.5706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:55:53.110613Z","caller":"traceutil/trace.go:171","msg":"trace[1178098453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:903; }","duration":"154.627922ms","start":"2026-04-07T05:55:52.955974Z","end":"2026-04-07T05:55:53.110602Z","steps":["trace[1178098453] 'agreement among raft nodes before linearized reading' (duration: 154.471538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:15.801263Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953875782564152,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T05:56:15.992183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.240687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:56:15.992333Z","caller":"traceutil/trace.go:171","msg":"trace[1725594821] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"696.927557ms","start":"2026-04-07T05:56:15.295385Z","end":"2026-04-07T05:56:15.992312Z","steps":["trace[1725594821] 'process raft request' (duration: 589.454734ms)","trace[1725594821] 'compare' (duration: 107.033051ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:56:15.992413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:15.29536Z","time spent":"697.011008ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:56:16.185638Z","caller":"traceutil/trace.go:171","msg":"trace[919645915] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1025; }","duration":"884.617133ms","start":"2026-04-07T05:56:15.300994Z","end":"2026-04-07T05:56:16.185611Z","steps":["trace[919645915] 'read index received' (duration: 583.865387ms)","trace[919645915] 'applied index is now lower than readState.Index' (duration: 300.750536ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:56:16.185696Z","caller":"traceutil/trace.go:171","msg":"trace[898965787] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"431.508857ms","start":"2026-04-07T05:56:15.754163Z","end":"2026-04-07T05:56:16.185671Z","steps":["trace[898965787] 'process raft request' (duration: 426.486286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:16.185818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:15.754136Z","time spent":"431.61853ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:56:16.185929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.280291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-07T05:56:16.185903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.869489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T05:56:16.185968Z","caller":"traceutil/trace.go:171","msg":"trace[1414295193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"802.350943ms","start":"2026-04-07T05:56:15.383606Z","end":"2026-04-07T05:56:16.185957Z","steps":["trace[1414295193] 'agreement among raft nodes before linearized reading' (duration: 802.153937ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:16.185992Z","caller":"traceutil/trace.go:171","msg":"trace[1386814913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:994; }","duration":"885.007704ms","start":"2026-04-07T05:56:15.300962Z","end":"2026-04-07T05:56:16.18597Z","steps":["trace[1386814913] 'agreement among raft nodes before linearized reading' (duration: 884.743356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:16.186002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:15.383595Z","time spent":"802.399695ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T05:56:16.186037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:15.300948Z","time spent":"885.079025ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T05:56:16.607662Z","caller":"traceutil/trace.go:171","msg":"trace[158179875] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"417.706336ms","start":"2026-04-07T05:56:16.189933Z","end":"2026-04-07T05:56:16.607639Z","steps":["trace[158179875] 'process raft request' (duration: 417.564482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:16.607807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:16.189908Z","time spent":"417.826179ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:56:16.6086Z","caller":"traceutil/trace.go:171","msg":"trace[1295871933] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1027; }","duration":"415.843086ms","start":"2026-04-07T05:56:16.192739Z","end":"2026-04-07T05:56:16.608583Z","steps":["trace[1295871933] 'read index received' (duration: 414.750468ms)","trace[1295871933] 'applied index is now lower than readState.Index' (duration: 1.091918ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:56:16.608699Z","caller":"traceutil/trace.go:171","msg":"trace[24402174] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"418.534876ms","start":"2026-04-07T05:56:16.190146Z","end":"2026-04-07T05:56:16.608681Z","steps":["trace[24402174] 'process raft request' (duration: 418.29278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:16.608783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:16.19012Z","time spent":"418.62035ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:56:16.608776Z","caller":"traceutil/trace.go:171","msg":"trace[379011138] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"418.419633ms","start":"2026-04-07T05:56:16.190333Z","end":"2026-04-07T05:56:16.608752Z","steps":["trace[379011138] 'process raft request' (duration: 418.193318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:16.608909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:16.190318Z","time spent":"418.519327ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:56:16.609038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.296908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:16.609152Z","caller":"traceutil/trace.go:171","msg":"trace[1194323972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"416.439242ms","start":"2026-04-07T05:56:16.192705Z","end":"2026-04-07T05:56:16.609144Z","steps":["trace[1194323972] 'agreement among raft nodes before linearized reading' (duration: 415.950939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:16.609175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:16.192693Z","time spent":"416.475663ms","remote":"127.0.0.1:45758","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-04-07T05:56:36.279263Z","caller":"traceutil/trace.go:171","msg":"trace[1377536107] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"198.230404ms","start":"2026-04-07T05:56:36.080998Z","end":"2026-04-07T05:56:36.279229Z","steps":["trace[1377536107] 'process raft request' (duration: 197.930766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:37.118492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.659095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:37.118588Z","caller":"traceutil/trace.go:171","msg":"trace[168221289] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1063; }","duration":"222.775208ms","start":"2026-04-07T05:56:36.895791Z","end":"2026-04-07T05:56:37.118567Z","steps":["trace[168221289] 'count revisions from in-memory index tree' (duration: 222.513221ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:37.119412Z","caller":"traceutil/trace.go:171","msg":"trace[1982792023] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"154.623588ms","start":"2026-04-07T05:56:36.964762Z","end":"2026-04-07T05:56:37.119385Z","steps":["trace[1982792023] 'process raft request' (duration: 154.484134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:37.351119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.512638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:37.351205Z","caller":"traceutil/trace.go:171","msg":"trace[1072061216] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1064; }","duration":"111.64102ms","start":"2026-04-07T05:56:37.239549Z","end":"2026-04-07T05:56:37.35119Z","steps":["trace[1072061216] 'count revisions from in-memory index tree' (duration: 111.401284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.540802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.064769ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T05:56:38.541066Z","caller":"traceutil/trace.go:171","msg":"trace[1786634667] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"294.318035ms","start":"2026-04-07T05:56:38.246709Z","end":"2026-04-07T05:56:38.541027Z","steps":["trace[1786634667] 'read index received' (duration: 168.058142ms)","trace[1786634667] 'applied index is now lower than readState.Index' (duration: 126.253283ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:56:38.541232Z","caller":"traceutil/trace.go:171","msg":"trace[1357184745] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"196.494548ms","start":"2026-04-07T05:56:38.344567Z","end":"2026-04-07T05:56:38.541062Z","steps":["trace[1357184745] 'process raft request' (duration: 196.346095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.541357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.776247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:56:38.54131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.551601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:38.541491Z","caller":"traceutil/trace.go:171","msg":"trace[1509593467] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1066; }","duration":"294.784538ms","start":"2026-04-07T05:56:38.246684Z","end":"2026-04-07T05:56:38.541468Z","steps":["trace[1509593467] 'agreement among raft nodes before linearized reading' (duration: 294.506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.541398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.929281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T05:56:38.541603Z","caller":"traceutil/trace.go:171","msg":"trace[190652600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1066; }","duration":"258.185747ms","start":"2026-04-07T05:56:38.283407Z","end":"2026-04-07T05:56:38.541593Z","steps":["trace[190652600] 'agreement among raft nodes before linearized reading' (duration: 257.838928ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:38.5414Z","caller":"traceutil/trace.go:171","msg":"trace[240482488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1066; }","duration":"241.860009ms","start":"2026-04-07T05:56:38.299528Z","end":"2026-04-07T05:56:38.541388Z","steps":["trace[240482488] 'agreement among raft nodes before linearized reading' (duration: 241.755216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.895644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.591229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-07T05:56:38.895668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.150755ms","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-04-07T05:56:38.895738Z","caller":"traceutil/trace.go:171","msg":"trace[2102648862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1067; }","duration":"124.729075ms","start":"2026-04-07T05:56:38.770988Z","end":"2026-04-07T05:56:38.895718Z","steps":["trace[2102648862] 'range keys from in-memory index tree' (duration: 124.414445ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:38.895743Z","caller":"traceutil/trace.go:171","msg":"trace[794819321] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1067; }","duration":"144.259816ms","start":"2026-04-07T05:56:38.751465Z","end":"2026-04-07T05:56:38.895725Z","steps":["trace[794819321] 'range keys from in-memory index tree' (duration: 143.971949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.89554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.823047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:56:38.896202Z","caller":"traceutil/trace.go:171","msg":"trace[1469950978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1067; }","duration":"130.528516ms","start":"2026-04-07T05:56:38.765657Z","end":"2026-04-07T05:56:38.896186Z","steps":["trace[1469950978] 'range keys from in-memory index tree' (duration: 129.681404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:50.587101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.934852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:50.58722Z","caller":"traceutil/trace.go:171","msg":"trace[200628797] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1155; }","duration":"527.127418ms","start":"2026-04-07T05:56:50.060067Z","end":"2026-04-07T05:56:50.587194Z","steps":["trace[200628797] 'count revisions from in-memory index tree' (duration: 526.8392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:50.587284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:50.060048Z","time spent":"527.21842ms","remote":"127.0.0.1:48598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:56:50.587603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.977732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:50.587728Z","caller":"traceutil/trace.go:171","msg":"trace[1639681183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1155; }","duration":"397.147226ms","start":"2026-04-07T05:56:50.190553Z","end":"2026-04-07T05:56:50.5877Z","steps":["trace[1639681183] 'range keys from in-memory index tree' (duration: 396.893309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:50.588003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.026773ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:50.588115Z","caller":"traceutil/trace.go:171","msg":"trace[1221834474] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1155; }","duration":"149.139936ms","start":"2026-04-07T05:56:50.438959Z","end":"2026-04-07T05:56:50.588099Z","steps":["trace[1221834474] 'range keys from in-memory index tree' (duration: 149.014503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:50.588379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:50.19053Z","time spent":"397.237168ms","remote":"127.0.0.1:45758","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-04-07T05:57:07.749361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.694424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-7c6hz\" ","response":"range_response_count:1 size:11057"} {"level":"info","ts":"2026-04-07T05:57:07.749476Z","caller":"traceutil/trace.go:171","msg":"trace[1757301062] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-7c6hz; range_end:; response_count:1; response_revision:1229; }","duration":"228.837818ms","start":"2026-04-07T05:57:07.520614Z","end":"2026-04-07T05:57:07.749452Z","steps":["trace[1757301062] 'range keys from in-memory index tree' (duration: 228.547179ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:07.910491Z","caller":"traceutil/trace.go:171","msg":"trace[485457829] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"155.860251ms","start":"2026-04-07T05:57:07.754558Z","end":"2026-04-07T05:57:07.910418Z","steps":["trace[485457829] 'process raft request' (duration: 155.687786ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:08.026741Z","caller":"traceutil/trace.go:171","msg":"trace[2119564960] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"268.320224ms","start":"2026-04-07T05:57:07.758402Z","end":"2026-04-07T05:57:08.026722Z","steps":["trace[2119564960] 'process raft request' (duration: 268.193741ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:08.779957Z","caller":"traceutil/trace.go:171","msg":"trace[352310092] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1282; }","duration":"115.947655ms","start":"2026-04-07T05:57:08.663989Z","end":"2026-04-07T05:57:08.779936Z","steps":["trace[352310092] 'read index received' (duration: 115.80906ms)","trace[352310092] 'applied index is now lower than readState.Index' (duration: 137.135µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:57:08.780027Z","caller":"traceutil/trace.go:171","msg":"trace[1841082623] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"213.149226ms","start":"2026-04-07T05:57:08.566816Z","end":"2026-04-07T05:57:08.779965Z","steps":["trace[1841082623] 'process raft request' (duration: 212.93737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:57:08.780081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.076248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:57:08.780415Z","caller":"traceutil/trace.go:171","msg":"trace[2026358712] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1237; }","duration":"116.455187ms","start":"2026-04-07T05:57:08.66395Z","end":"2026-04-07T05:57:08.780405Z","steps":["trace[2026358712] 'agreement among raft nodes before linearized reading' (duration: 116.066218ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:08.908406Z","caller":"traceutil/trace.go:171","msg":"trace[1248415404] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"224.241766ms","start":"2026-04-07T05:57:08.684133Z","end":"2026-04-07T05:57:08.908375Z","steps":["trace[1248415404] 'process raft request' (duration: 136.422391ms)","trace[1248415404] 'compare' (duration: 87.588439ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:57:08.908585Z","caller":"traceutil/trace.go:171","msg":"trace[541280542] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"123.804579ms","start":"2026-04-07T05:57:08.784756Z","end":"2026-04-07T05:57:08.90856Z","steps":["trace[541280542] 'process raft request' (duration: 123.525072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:57:09.234012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.369503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:57:09.234137Z","caller":"traceutil/trace.go:171","msg":"trace[1357596550] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"318.049709ms","start":"2026-04-07T05:57:08.916063Z","end":"2026-04-07T05:57:09.234112Z","steps":["trace[1357596550] 'process raft request' (duration: 123.420739ms)","trace[1357596550] 'compare' (duration: 193.856769ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:57:09.23422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:57:08.916043Z","time spent":"318.134311ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:57:09.234608Z","caller":"traceutil/trace.go:171","msg":"trace[306601204] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"316.040856ms","start":"2026-04-07T05:57:08.918554Z","end":"2026-04-07T05:57:09.234594Z","steps":["trace[306601204] 'process raft request' (duration: 315.976124ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:09.234592Z","caller":"traceutil/trace.go:171","msg":"trace[453385314] linearizableReadLoop","detail":"{readStateIndex:1288; appliedIndex:1285; }","duration":"314.771014ms","start":"2026-04-07T05:57:08.919798Z","end":"2026-04-07T05:57:09.234569Z","steps":["trace[453385314] 'read index received' (duration: 119.610311ms)","trace[453385314] 'applied index is now lower than readState.Index' (duration: 195.159783ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:57:09.234673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:57:08.918543Z","time spent":"316.093688ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:57:09.234609Z","caller":"traceutil/trace.go:171","msg":"trace[2043412881] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"317.860624ms","start":"2026-04-07T05:57:08.916712Z","end":"2026-04-07T05:57:09.234573Z","steps":["trace[2043412881] 'process raft request' (duration: 317.70421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:57:09.234869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.04179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-07T05:57:09.234911Z","caller":"traceutil/trace.go:171","msg":"trace[1832374762] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1242; }","duration":"315.159553ms","start":"2026-04-07T05:57:08.919738Z","end":"2026-04-07T05:57:09.234898Z","steps":["trace[1832374762] 'agreement among raft nodes before linearized reading' (duration: 314.949858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:57:09.234932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:57:08.916679Z","time spent":"318.158272ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:57:09.234963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:57:08.919725Z","time spent":"315.226985ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-07T05:57:10.081531Z","caller":"traceutil/trace.go:171","msg":"trace[746573431] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"162.343141ms","start":"2026-04-07T05:57:09.919164Z","end":"2026-04-07T05:57:10.081507Z","steps":["trace[746573431] 'process raft request' (duration: 162.214268ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:21.149347Z","caller":"traceutil/trace.go:171","msg":"trace[79244105] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"204.195916ms","start":"2026-04-07T05:57:20.945127Z","end":"2026-04-07T05:57:21.149322Z","steps":["trace[79244105] 'process raft request' (duration: 204.058402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:57:21.429581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.841117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:57:21.429899Z","caller":"traceutil/trace.go:171","msg":"trace[2121659984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1323; }","duration":"103.158556ms","start":"2026-04-07T05:57:21.326691Z","end":"2026-04-07T05:57:21.42985Z","steps":["trace[2121659984] 'range keys from in-memory index tree' (duration: 102.737715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:57:21.429994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.212272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:57:21.430076Z","caller":"traceutil/trace.go:171","msg":"trace[455216451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1323; }","duration":"128.46361ms","start":"2026-04-07T05:57:21.301592Z","end":"2026-04-07T05:57:21.430056Z","steps":["trace[455216451] 'range keys from in-memory index tree' (duration: 127.662739ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:21.600658Z","caller":"traceutil/trace.go:171","msg":"trace[1346721567] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"166.935408ms","start":"2026-04-07T05:57:21.433702Z","end":"2026-04-07T05:57:21.600637Z","steps":["trace[1346721567] 'process raft request' (duration: 166.775114ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:21.601257Z","caller":"traceutil/trace.go:171","msg":"trace[1414960981] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"163.986101ms","start":"2026-04-07T05:57:21.437245Z","end":"2026-04-07T05:57:21.601231Z","steps":["trace[1414960981] 'process raft request' (duration: 163.94837ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:21.601574Z","caller":"traceutil/trace.go:171","msg":"trace[824072521] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"167.249357ms","start":"2026-04-07T05:57:21.434314Z","end":"2026-04-07T05:57:21.601563Z","steps":["trace[824072521] 'process raft request' (duration: 166.696282ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:21.601661Z","caller":"traceutil/trace.go:171","msg":"trace[972147968] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"166.292742ms","start":"2026-04-07T05:57:21.435355Z","end":"2026-04-07T05:57:21.601647Z","steps":["trace[972147968] 'process raft request' (duration: 165.810929ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:57:21.601974Z","caller":"traceutil/trace.go:171","msg":"trace[410940045] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"167.557714ms","start":"2026-04-07T05:57:21.434375Z","end":"2026-04-07T05:57:21.601933Z","steps":["trace[410940045] 'process raft request' (duration: 166.754593ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:15.900078Z","caller":"traceutil/trace.go:171","msg":"trace[1723300353] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"383.841615ms","start":"2026-04-07T05:59:15.516212Z","end":"2026-04-07T05:59:15.900053Z","steps":["trace[1723300353] 'process raft request' (duration: 383.692812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:15.90023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:59:15.516188Z","time spent":"383.967469ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:59:22.258358Z","caller":"traceutil/trace.go:171","msg":"trace[1657352659] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"104.943231ms","start":"2026-04-07T05:59:22.153394Z","end":"2026-04-07T05:59:22.258337Z","steps":["trace[1657352659] 'process raft request' (duration: 104.661554ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:22.45822Z","caller":"traceutil/trace.go:171","msg":"trace[475471408] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"195.006664ms","start":"2026-04-07T05:59:22.263176Z","end":"2026-04-07T05:59:22.458183Z","steps":["trace[475471408] 'process raft request' (duration: 163.950385ms)","trace[475471408] 'compare' (duration: 30.816462ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:22.458365Z","caller":"traceutil/trace.go:171","msg":"trace[1735255391] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1951; }","duration":"131.677106ms","start":"2026-04-07T05:59:22.32666Z","end":"2026-04-07T05:59:22.458337Z","steps":["trace[1735255391] 'read index received' (duration: 100.398892ms)","trace[1735255391] 'applied index is now lower than readState.Index' (duration: 31.276424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:22.458471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.789959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:59:22.458506Z","caller":"traceutil/trace.go:171","msg":"trace[1543401677] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1881; }","duration":"131.87033ms","start":"2026-04-07T05:59:22.326626Z","end":"2026-04-07T05:59:22.458496Z","steps":["trace[1543401677] 'agreement among raft nodes before linearized reading' (duration: 131.795678ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:22.458474Z","caller":"traceutil/trace.go:171","msg":"trace[2121817128] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"195.171498ms","start":"2026-04-07T05:59:22.263208Z","end":"2026-04-07T05:59:22.458379Z","steps":["trace[2121817128] 'process raft request' (duration: 194.918932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:22.458553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.811214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-07T05:59:22.458591Z","caller":"traceutil/trace.go:171","msg":"trace[1350339874] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1881; }","duration":"122.868006ms","start":"2026-04-07T05:59:22.33571Z","end":"2026-04-07T05:59:22.458578Z","steps":["trace[1350339874] 'agreement among raft nodes before linearized reading' (duration: 122.756823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:23.398544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.596669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T05:59:23.398628Z","caller":"traceutil/trace.go:171","msg":"trace[667345377] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1885; }","duration":"180.711941ms","start":"2026-04-07T05:59:23.217898Z","end":"2026-04-07T05:59:23.39861Z","steps":["trace[667345377] 'range keys from in-memory index tree' (duration: 180.474866ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:24.087537Z","caller":"traceutil/trace.go:171","msg":"trace[1929667668] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"101.522811ms","start":"2026-04-07T05:59:23.98599Z","end":"2026-04-07T05:59:24.087513Z","steps":["trace[1929667668] 'process raft request' (duration: 101.390648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:24.792168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.47591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:59:24.792274Z","caller":"traceutil/trace.go:171","msg":"trace[1329201015] linearizableReadLoop","detail":"{readStateIndex:1964; appliedIndex:1962; }","duration":"299.046319ms","start":"2026-04-07T05:59:24.493212Z","end":"2026-04-07T05:59:24.792258Z","steps":["trace[1329201015] 'read index received' (duration: 17.982277ms)","trace[1329201015] 'applied index is now lower than readState.Index' (duration: 281.062952ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:24.792385Z","caller":"traceutil/trace.go:171","msg":"trace[164857153] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"322.4959ms","start":"2026-04-07T05:59:24.469831Z","end":"2026-04-07T05:59:24.792327Z","steps":["trace[164857153] 'process raft request' (duration: 195.772353ms)","trace[164857153] 'compare' (duration: 126.282465ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:24.792536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:59:24.4698Z","time spent":"322.655034ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:59:24.79257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.341757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-04-07T05:59:24.792627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.567577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T05:59:24.792657Z","caller":"traceutil/trace.go:171","msg":"trace[1671564844] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1891; }","duration":"299.475991ms","start":"2026-04-07T05:59:24.493158Z","end":"2026-04-07T05:59:24.792634Z","steps":["trace[1671564844] 'agreement among raft nodes before linearized reading' (duration: 299.193074ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:24.792668Z","caller":"traceutil/trace.go:171","msg":"trace[691729438] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1891; }","duration":"105.654869ms","start":"2026-04-07T05:59:24.687002Z","end":"2026-04-07T05:59:24.792657Z","steps":["trace[691729438] 'agreement among raft nodes before linearized reading' (duration: 105.497945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:24.793324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.107775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-07T05:59:24.793414Z","caller":"traceutil/trace.go:171","msg":"trace[2083908576] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1891; }","duration":"238.252028ms","start":"2026-04-07T05:59:24.555142Z","end":"2026-04-07T05:59:24.793394Z","steps":["trace[2083908576] 'agreement among raft nodes before linearized reading' (duration: 237.267233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:26.332714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.022113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:59:26.332805Z","caller":"traceutil/trace.go:171","msg":"trace[976824698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1895; }","duration":"140.161937ms","start":"2026-04-07T05:59:26.192624Z","end":"2026-04-07T05:59:26.332786Z","steps":["trace[976824698] 'range keys from in-memory index tree' (duration: 139.935431ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:26.736952Z","caller":"traceutil/trace.go:171","msg":"trace[481878155] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"201.177803ms","start":"2026-04-07T05:59:26.535738Z","end":"2026-04-07T05:59:26.736916Z","steps":["trace[481878155] 'process raft request' (duration: 153.021121ms)","trace[481878155] 'compare' (duration: 48.047969ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:28.689243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.788445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-07T05:59:28.689348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.922918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T05:59:28.68934Z","caller":"traceutil/trace.go:171","msg":"trace[1170178231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1905; }","duration":"300.921159ms","start":"2026-04-07T05:59:28.388397Z","end":"2026-04-07T05:59:28.689318Z","steps":["trace[1170178231] 'range keys from in-memory index tree' (duration: 300.617681ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:28.689384Z","caller":"traceutil/trace.go:171","msg":"trace[1376907411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1905; }","duration":"285.991729ms","start":"2026-04-07T05:59:28.403383Z","end":"2026-04-07T05:59:28.689375Z","steps":["trace[1376907411] 'range keys from in-memory index tree' (duration: 285.834285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:28.689409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:59:28.388383Z","time spent":"301.006131ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T05:59:28.881117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.37797ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T05:59:28.881474Z","caller":"traceutil/trace.go:171","msg":"trace[1611929826] linearizableReadLoop","detail":"{readStateIndex:1979; appliedIndex:1978; }","duration":"305.593191ms","start":"2026-04-07T05:59:28.575825Z","end":"2026-04-07T05:59:28.881418Z","steps":["trace[1611929826] 'read index received' (duration: 53.847281ms)","trace[1611929826] 'applied index is now lower than readState.Index' (duration: 251.74027ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:28.881574Z","caller":"traceutil/trace.go:171","msg":"trace[961377732] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"187.323753ms","start":"2026-04-07T05:59:28.69423Z","end":"2026-04-07T05:59:28.881554Z","steps":["trace[961377732] 'process raft request' (duration: 187.270952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:28.881806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.96934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T05:59:28.881654Z","caller":"traceutil/trace.go:171","msg":"trace[233073920] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"187.94429ms","start":"2026-04-07T05:59:28.693685Z","end":"2026-04-07T05:59:28.88163Z","steps":["trace[233073920] 'process raft request' (duration: 187.535489ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:28.88197Z","caller":"traceutil/trace.go:171","msg":"trace[1044901317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1907; }","duration":"306.021431ms","start":"2026-04-07T05:59:28.575813Z","end":"2026-04-07T05:59:28.881834Z","steps":["trace[1044901317] 'agreement among raft nodes before linearized reading' (duration: 305.806916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:28.882123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:59:28.575761Z","time spent":"306.293409ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T05:59:29.144769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.5325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:59:29.145022Z","caller":"traceutil/trace.go:171","msg":"trace[1995044510] linearizableReadLoop","detail":"{readStateIndex:1983; appliedIndex:1982; }","duration":"231.283366ms","start":"2026-04-07T05:59:28.913678Z","end":"2026-04-07T05:59:29.144961Z","steps":["trace[1995044510] 'read index received' (duration: 48.488001ms)","trace[1995044510] 'applied index is now lower than readState.Index' (duration: 182.793875ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:29.145061Z","caller":"traceutil/trace.go:171","msg":"trace[1801571755] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"256.953265ms","start":"2026-04-07T05:59:28.888066Z","end":"2026-04-07T05:59:29.14502Z","steps":["trace[1801571755] 'process raft request' (duration: 142.095677ms)","trace[1801571755] 'compare' (duration: 114.435107ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:29.145257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.580763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T05:59:29.145302Z","caller":"traceutil/trace.go:171","msg":"trace[2054033392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1909; }","duration":"231.665926ms","start":"2026-04-07T05:59:28.913622Z","end":"2026-04-07T05:59:29.145288Z","steps":["trace[2054033392] 'agreement among raft nodes before linearized reading' (duration: 231.513672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:29.145596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.616491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-07T05:59:29.145596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.587259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-07T05:59:29.145655Z","caller":"traceutil/trace.go:171","msg":"trace[2012894805] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1909; }","duration":"197.717913ms","start":"2026-04-07T05:59:28.94792Z","end":"2026-04-07T05:59:29.145638Z","steps":["trace[2012894805] 'agreement among raft nodes before linearized reading' (duration: 197.514228ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:29.145672Z","caller":"traceutil/trace.go:171","msg":"trace[897626818] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1909; }","duration":"117.708952ms","start":"2026-04-07T05:59:29.027941Z","end":"2026-04-07T05:59:29.14565Z","steps":["trace[897626818] 'agreement among raft nodes before linearized reading' (duration: 117.487357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:29.358933Z","caller":"traceutil/trace.go:171","msg":"trace[988508073] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1984; }","duration":"165.914827ms","start":"2026-04-07T05:59:29.192993Z","end":"2026-04-07T05:59:29.358907Z","steps":["trace[988508073] 'read index received' (duration: 1.081788ms)","trace[988508073] 'applied index is now lower than readState.Index' (duration: 164.831989ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:29.359088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.071121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:59:29.359128Z","caller":"traceutil/trace.go:171","msg":"trace[1066773330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1912; }","duration":"166.157693ms","start":"2026-04-07T05:59:29.192958Z","end":"2026-04-07T05:59:29.359116Z","steps":["trace[1066773330] 'agreement among raft nodes before linearized reading' (duration: 166.060731ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:29.359182Z","caller":"traceutil/trace.go:171","msg":"trace[2064633936] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"208.535665ms","start":"2026-04-07T05:59:29.150611Z","end":"2026-04-07T05:59:29.359147Z","steps":["trace[2064633936] 'process raft request' (duration: 208.104653ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:29.359226Z","caller":"traceutil/trace.go:171","msg":"trace[578249734] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"208.395042ms","start":"2026-04-07T05:59:29.150792Z","end":"2026-04-07T05:59:29.359187Z","steps":["trace[578249734] 'process raft request' (duration: 208.070464ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.204412Z","caller":"traceutil/trace.go:171","msg":"trace[1176040068] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"131.834061ms","start":"2026-04-07T05:59:57.072551Z","end":"2026-04-07T05:59:57.204386Z","steps":["trace[1176040068] 'process raft request' (duration: 126.0733ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.274271Z","caller":"traceutil/trace.go:171","msg":"trace[164176325] linearizableReadLoop","detail":"{readStateIndex:2116; appliedIndex:2114; }","duration":"179.082808ms","start":"2026-04-07T05:59:57.095173Z","end":"2026-04-07T05:59:57.274256Z","steps":["trace[164176325] 'read index received' (duration: 103.470102ms)","trace[164176325] 'applied index is now lower than readState.Index' (duration: 75.611546ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:57.274397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.216642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:59:57.274434Z","caller":"traceutil/trace.go:171","msg":"trace[394363417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2038; }","duration":"179.294795ms","start":"2026-04-07T05:59:57.095128Z","end":"2026-04-07T05:59:57.274422Z","steps":["trace[394363417] 'agreement among raft nodes before linearized reading' (duration: 179.222823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:57.274742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.923989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:59:57.274817Z","caller":"traceutil/trace.go:171","msg":"trace[1244976035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2038; }","duration":"173.054752ms","start":"2026-04-07T05:59:57.101747Z","end":"2026-04-07T05:59:57.274802Z","steps":["trace[1244976035] 'agreement among raft nodes before linearized reading' (duration: 172.684203ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.274365Z","caller":"traceutil/trace.go:171","msg":"trace[286164347] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"201.654025ms","start":"2026-04-07T05:59:57.072677Z","end":"2026-04-07T05:59:57.274331Z","steps":["trace[286164347] 'process raft request' (duration: 201.44955ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.423686Z","caller":"traceutil/trace.go:171","msg":"trace[554985432] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"144.441948ms","start":"2026-04-07T05:59:57.27922Z","end":"2026-04-07T05:59:57.423662Z","steps":["trace[554985432] 'process raft request' (duration: 144.317905ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.423689Z","caller":"traceutil/trace.go:171","msg":"trace[1153470182] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"144.957001ms","start":"2026-04-07T05:59:57.278676Z","end":"2026-04-07T05:59:57.423633Z","steps":["trace[1153470182] 'process raft request' (duration: 47.64027ms)","trace[1153470182] 'compare' (duration: 97.073794ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:57.651497Z","caller":"traceutil/trace.go:171","msg":"trace[473400634] linearizableReadLoop","detail":"{readStateIndex:2121; appliedIndex:2120; }","duration":"106.380177ms","start":"2026-04-07T05:59:57.54509Z","end":"2026-04-07T05:59:57.651471Z","steps":["trace[473400634] 'read index received' (duration: 79.610091ms)","trace[473400634] 'applied index is now lower than readState.Index' (duration: 26.766446ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:57.651695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.587282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:59:57.651677Z","caller":"traceutil/trace.go:171","msg":"trace[1440076705] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"157.755843ms","start":"2026-04-07T05:59:57.493856Z","end":"2026-04-07T05:59:57.651612Z","steps":["trace[1440076705] 'process raft request' (duration: 130.900595ms)","trace[1440076705] 'compare' (duration: 26.573111ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:57.65174Z","caller":"traceutil/trace.go:171","msg":"trace[640085275] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2042; }","duration":"106.702906ms","start":"2026-04-07T05:59:57.545026Z","end":"2026-04-07T05:59:57.651729Z","steps":["trace[640085275] 'agreement among raft nodes before linearized reading' (duration: 106.601603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:58.746928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.361888ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T05:59:59.854233Z","caller":"traceutil/trace.go:171","msg":"trace[98665211] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"195.355362ms","start":"2026-04-07T05:59:59.658846Z","end":"2026-04-07T05:59:59.854202Z","steps":["trace[98665211] 'process raft request' (duration: 195.184407ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:00.579512Z","caller":"traceutil/trace.go:171","msg":"trace[1994886744] linearizableReadLoop","detail":"{readStateIndex:2133; appliedIndex:2132; }","duration":"170.333821ms","start":"2026-04-07T06:00:00.409153Z","end":"2026-04-07T06:00:00.579487Z","steps":["trace[1994886744] 'read index received' (duration: 170.041514ms)","trace[1994886744] 'applied index is now lower than readState.Index' (duration: 291.417µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:00.579671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.502586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:00.579714Z","caller":"traceutil/trace.go:171","msg":"trace[1737352855] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2053; }","duration":"170.625709ms","start":"2026-04-07T06:00:00.409076Z","end":"2026-04-07T06:00:00.579701Z","steps":["trace[1737352855] 'agreement among raft nodes before linearized reading' (duration: 170.508546ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:00.579686Z","caller":"traceutil/trace.go:171","msg":"trace[1062509093] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"231.510423ms","start":"2026-04-07T06:00:00.348114Z","end":"2026-04-07T06:00:00.579624Z","steps":["trace[1062509093] 'process raft request' (duration: 231.175404ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:01.756475Z","caller":"traceutil/trace.go:171","msg":"trace[2109183781] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"181.682777ms","start":"2026-04-07T06:00:01.574769Z","end":"2026-04-07T06:00:01.756452Z","steps":["trace[2109183781] 'process raft request' (duration: 181.545003ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:01.79675Z","caller":"traceutil/trace.go:171","msg":"trace[840890061] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"221.655616ms","start":"2026-04-07T06:00:01.575075Z","end":"2026-04-07T06:00:01.79673Z","steps":["trace[840890061] 'process raft request' (duration: 221.544723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:01.976906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.053761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-07T06:00:01.976987Z","caller":"traceutil/trace.go:171","msg":"trace[192019364] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2059; }","duration":"118.185335ms","start":"2026-04-07T06:00:01.858785Z","end":"2026-04-07T06:00:01.97697Z","steps":["trace[192019364] 'range keys from in-memory index tree' (duration: 117.807734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.972825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.836628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:00:02.9729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.723554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-07T06:00:02.972932Z","caller":"traceutil/trace.go:171","msg":"trace[1546920776] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2060; }","duration":"779.998322ms","start":"2026-04-07T06:00:02.19291Z","end":"2026-04-07T06:00:02.972909Z","steps":["trace[1546920776] 'range keys from in-memory index tree' (duration: 779.661333ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:02.972964Z","caller":"traceutil/trace.go:171","msg":"trace[1555823169] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2060; }","duration":"764.818836ms","start":"2026-04-07T06:00:02.208117Z","end":"2026-04-07T06:00:02.972936Z","steps":["trace[1555823169] 'range keys from in-memory index tree' (duration: 764.525579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.972978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.54658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:00:02.973022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:02.208093Z","time spent":"764.917208ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-07T06:00:02.973063Z","caller":"traceutil/trace.go:171","msg":"trace[992785802] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2060; }","duration":"528.641012ms","start":"2026-04-07T06:00:02.4444Z","end":"2026-04-07T06:00:02.973041Z","steps":["trace[992785802] 'count revisions from in-memory index tree' (duration: 528.471158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.973111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:02.44435Z","time spent":"528.750745ms","remote":"127.0.0.1:48482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:00:02.972996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:02.192888Z","time spent":"780.092773ms","remote":"127.0.0.1:45764","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-04-07T06:00:02.972845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.161621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:02.973611Z","caller":"traceutil/trace.go:171","msg":"trace[1289104496] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2060; }","duration":"889.941702ms","start":"2026-04-07T06:00:02.083614Z","end":"2026-04-07T06:00:02.973556Z","steps":["trace[1289104496] 'count revisions from in-memory index tree' (duration: 889.062729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.973728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:02.083594Z","time spent":"890.110075ms","remote":"127.0.0.1:48390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:00:02.973492Z","caller":"traceutil/trace.go:171","msg":"trace[484241492] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"388.759574ms","start":"2026-04-07T06:00:02.584717Z","end":"2026-04-07T06:00:02.973476Z","steps":["trace[484241492] 'process raft request' (duration: 332.648494ms)","trace[484241492] 'compare' (duration: 55.833053ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:02.974169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:02.58469Z","time spent":"389.251197ms","remote":"127.0.0.1:45982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:00:03.266606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.956688ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:00:03.266709Z","caller":"traceutil/trace.go:171","msg":"trace[1049430891] linearizableReadLoop","detail":"{readStateIndex:2142; appliedIndex:2141; }","duration":"238.038693ms","start":"2026-04-07T06:00:03.028654Z","end":"2026-04-07T06:00:03.266693Z","steps":["trace[1049430891] 'read index received' (duration: 71.870899ms)","trace[1049430891] 'applied index is now lower than readState.Index' (duration: 166.166684ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:03.266794Z","caller":"traceutil/trace.go:171","msg":"trace[1244512203] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"289.395008ms","start":"2026-04-07T06:00:02.977388Z","end":"2026-04-07T06:00:03.266783Z","steps":["trace[1244512203] 'process raft request' (duration: 123.166743ms)","trace[1244512203] 'compare' (duration: 165.828764ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:03.267079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.842003ms","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-04-07T06:00:03.267114Z","caller":"traceutil/trace.go:171","msg":"trace[1321125060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2062; }","duration":"120.915345ms","start":"2026-04-07T06:00:03.146189Z","end":"2026-04-07T06:00:03.267104Z","steps":["trace[1321125060] 'agreement among raft nodes before linearized reading' (duration: 120.784292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:03.267144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.469693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-07T06:00:03.26724Z","caller":"traceutil/trace.go:171","msg":"trace[1803933177] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2062; }","duration":"238.613018ms","start":"2026-04-07T06:00:03.028604Z","end":"2026-04-07T06:00:03.267217Z","steps":["trace[1803933177] 'agreement among raft nodes before linearized reading' (duration: 238.35515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:03.26755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.823656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T06:00:03.267609Z","caller":"traceutil/trace.go:171","msg":"trace[1454327412] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:2062; }","duration":"132.919318ms","start":"2026-04-07T06:00:03.134675Z","end":"2026-04-07T06:00:03.267595Z","steps":["trace[1454327412] 'agreement among raft nodes before linearized reading' (duration: 132.23298ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:03.570728Z","caller":"traceutil/trace.go:171","msg":"trace[152126396] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"298.387632ms","start":"2026-04-07T06:00:03.272331Z","end":"2026-04-07T06:00:03.570718Z","steps":["trace[152126396] 'process raft request' (duration: 298.151666ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:03.57067Z","caller":"traceutil/trace.go:171","msg":"trace[1706364052] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"298.089786ms","start":"2026-04-07T06:00:03.272563Z","end":"2026-04-07T06:00:03.570653Z","steps":["trace[1706364052] 'process raft request' (duration: 298.057735ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:03.61599Z","caller":"traceutil/trace.go:171","msg":"trace[244161598] linearizableReadLoop","detail":"{readStateIndex:2146; appliedIndex:2143; }","duration":"252.577952ms","start":"2026-04-07T06:00:03.363391Z","end":"2026-04-07T06:00:03.615969Z","steps":["trace[244161598] 'read index received' (duration: 207.128809ms)","trace[244161598] 'applied index is now lower than readState.Index' (duration: 45.448183ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:03.616037Z","caller":"traceutil/trace.go:171","msg":"trace[1237414528] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"309.509811ms","start":"2026-04-07T06:00:03.306492Z","end":"2026-04-07T06:00:03.616002Z","steps":["trace[1237414528] 'process raft request' (duration: 309.339657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:03.616261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:03.306467Z","time spent":"309.683676ms","remote":"127.0.0.1:45794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:00:03.616483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.075364ms","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-04-07T06:00:03.616639Z","caller":"traceutil/trace.go:171","msg":"trace[1989557841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2065; }","duration":"253.241019ms","start":"2026-04-07T06:00:03.363383Z","end":"2026-04-07T06:00:03.616624Z","steps":["trace[1989557841] 'agreement among raft nodes before linearized reading' (duration: 252.738645ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:03.789172Z","caller":"traceutil/trace.go:171","msg":"trace[529113031] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"169.287024ms","start":"2026-04-07T06:00:03.619857Z","end":"2026-04-07T06:00:03.789144Z","steps":["trace[529113031] 'process raft request' (duration: 77.565998ms)","trace[529113031] 'compare' (duration: 91.616674ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:03.848257Z","caller":"traceutil/trace.go:171","msg":"trace[820185015] linearizableReadLoop","detail":"{readStateIndex:2148; appliedIndex:2146; }","duration":"227.319093ms","start":"2026-04-07T06:00:03.620915Z","end":"2026-04-07T06:00:03.848234Z","steps":["trace[820185015] 'read index received' (duration: 76.453049ms)","trace[820185015] 'applied index is now lower than readState.Index' (duration: 150.864934ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:03.848348Z","caller":"traceutil/trace.go:171","msg":"trace[2010149093] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"228.429413ms","start":"2026-04-07T06:00:03.619894Z","end":"2026-04-07T06:00:03.848324Z","steps":["trace[2010149093] 'process raft request' (duration: 228.217137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:03.848454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.520239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T06:00:03.848642Z","caller":"traceutil/trace.go:171","msg":"trace[488487717] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2067; }","duration":"227.731944ms","start":"2026-04-07T06:00:03.620891Z","end":"2026-04-07T06:00:03.848623Z","steps":["trace[488487717] 'agreement among raft nodes before linearized reading' (duration: 227.503678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:04.058631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.679872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:00:04.05888Z","caller":"traceutil/trace.go:171","msg":"trace[1261586966] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"206.358448ms","start":"2026-04-07T06:00:03.852494Z","end":"2026-04-07T06:00:04.058853Z","steps":["trace[1261586966] 'process raft request' (duration: 68.381388ms)","trace[1261586966] 'compare' (duration: 137.566349ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:04.058917Z","caller":"traceutil/trace.go:171","msg":"trace[225174175] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"206.002329ms","start":"2026-04-07T06:00:03.852887Z","end":"2026-04-07T06:00:04.058889Z","steps":["trace[225174175] 'process raft request' (duration: 205.835205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:04.32434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.077405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:00:04.324444Z","caller":"traceutil/trace.go:171","msg":"trace[1302155953] linearizableReadLoop","detail":"{readStateIndex:2151; appliedIndex:2150; }","duration":"131.935572ms","start":"2026-04-07T06:00:04.192493Z","end":"2026-04-07T06:00:04.324429Z","steps":["trace[1302155953] 'read index received' (duration: 14.62149ms)","trace[1302155953] 'applied index is now lower than readState.Index' (duration: 117.313002ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:04.324501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.007015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:04.324525Z","caller":"traceutil/trace.go:171","msg":"trace[1387731323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2070; }","duration":"132.059555ms","start":"2026-04-07T06:00:04.192457Z","end":"2026-04-07T06:00:04.324516Z","steps":["trace[1387731323] 'agreement among raft nodes before linearized reading' (duration: 132.012834ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:04.324573Z","caller":"traceutil/trace.go:171","msg":"trace[1926601590] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"261.971585ms","start":"2026-04-07T06:00:04.062554Z","end":"2026-04-07T06:00:04.324526Z","steps":["trace[1926601590] 'process raft request' (duration: 144.635092ms)","trace[1926601590] 'compare' (duration: 116.963832ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:05.296107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.95585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-07T06:00:05.296378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.547096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:05.296452Z","caller":"traceutil/trace.go:171","msg":"trace[1709424507] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2073; }","duration":"193.658689ms","start":"2026-04-07T06:00:05.10278Z","end":"2026-04-07T06:00:05.296439Z","steps":["trace[1709424507] 'agreement among raft nodes before linearized reading' (duration: 193.554466ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:05.296301Z","caller":"traceutil/trace.go:171","msg":"trace[1483654180] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"221.889883ms","start":"2026-04-07T06:00:05.074371Z","end":"2026-04-07T06:00:05.296261Z","steps":["trace[1483654180] 'process raft request' (duration: 101.678085ms)","trace[1483654180] 'compare' (duration: 119.738635ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:05.2963Z","caller":"traceutil/trace.go:171","msg":"trace[631872268] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2153; }","duration":"193.452684ms","start":"2026-04-07T06:00:05.102831Z","end":"2026-04-07T06:00:05.296284Z","steps":["trace[631872268] 'read index received' (duration: 73.208766ms)","trace[631872268] 'applied index is now lower than readState.Index' (duration: 120.180717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:05.297252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.871582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:05.297311Z","caller":"traceutil/trace.go:171","msg":"trace[1430867560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2073; }","duration":"103.995655ms","start":"2026-04-07T06:00:05.19329Z","end":"2026-04-07T06:00:05.297286Z","steps":["trace[1430867560] 'agreement among raft nodes before linearized reading' (duration: 103.844361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:05.708495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.725129ms","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-04-07T06:00:05.708569Z","caller":"traceutil/trace.go:171","msg":"trace[514681516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2073; }","duration":"133.872023ms","start":"2026-04-07T06:00:05.574679Z","end":"2026-04-07T06:00:05.708551Z","steps":["trace[514681516] 'range keys from in-memory index tree' (duration: 133.494302ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:05.936025Z","caller":"traceutil/trace.go:171","msg":"trace[612191675] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"138.35905ms","start":"2026-04-07T06:00:05.797638Z","end":"2026-04-07T06:00:05.935997Z","steps":["trace[612191675] 'process raft request' (duration: 94.713624ms)","trace[612191675] 'compare' (duration: 43.220935ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:06.28228Z","caller":"traceutil/trace.go:171","msg":"trace[24851642] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"194.066138ms","start":"2026-04-07T06:00:06.088185Z","end":"2026-04-07T06:00:06.282251Z","steps":["trace[24851642] 'process raft request' (duration: 130.647999ms)","trace[24851642] 'compare' (duration: 63.218814ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:06.478902Z","caller":"traceutil/trace.go:171","msg":"trace[148453645] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"143.144573ms","start":"2026-04-07T06:00:06.335732Z","end":"2026-04-07T06:00:06.478877Z","steps":["trace[148453645] 'process raft request' (duration: 78.263395ms)","trace[148453645] 'compare' (duration: 64.760056ms)"],"step_count":2}