{"level":"warn","ts":"2026-04-27T01:29:33.958113Z","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-27T01:29:33.958206Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-27T01:29:33.958296Z","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-27T01:29:33.958314Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-27T01:29:33.958336Z","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-27T01:29:33.958976Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-04-27T01:29:33.959068Z","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":16,"max-cpu-available":16,"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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-27T01:29:33.964185Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.864467ms"} {"level":"info","ts":"2026-04-27T01:29:33.969706Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-04-27T01:29:33.969846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T01:29:33.969902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-04-27T01:29:33.969927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T01:29:33.969966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-04-27T01:29:33.970026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-04-27T01:29:33.976166Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T01:29:33.977823Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T01:29:33.978962Z","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-27T01:29:33.982169Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T01:29:33.982496Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T01:29:33.982534Z","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-27T01:29:33.98264Z","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-27T01:29:33.982663Z","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-27T01:29:33.984506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-04-27T01:29:33.98552Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-27T01:29:33.989138Z","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-27T01:29:33.989328Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-27T01:29:33.989383Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-27T01:29:33.989561Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T01:29:33.989629Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T01:29:34.970687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T01:29:34.97075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T01:29:34.970791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-04-27T01:29:34.970811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-04-27T01:29:34.970824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-27T01:29:34.970853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-04-27T01:29:34.970881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-27T01:29:34.972027Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:29:34.973157Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:29:34.973168Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T01:29:34.973226Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:29:34.973584Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:29:34.973722Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:29:34.97376Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:29:34.973701Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T01:29:34.973919Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T01:29:34.976675Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T01:29:34.976818Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-04-27T01:29:58.618451Z","caller":"traceutil/trace.go:171","msg":"trace[10684437] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"265.059599ms","start":"2026-04-27T01:29:58.35337Z","end":"2026-04-27T01:29:58.618429Z","steps":["trace[10684437] 'process raft request' (duration: 264.626371ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:08.115909Z","caller":"traceutil/trace.go:171","msg":"trace[1045484364] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"237.489153ms","start":"2026-04-27T01:30:07.878398Z","end":"2026-04-27T01:30:08.115887Z","steps":["trace[1045484364] 'read index received' (duration: 237.055535ms)","trace[1045484364] 'applied index is now lower than readState.Index' (duration: 432.438µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:30:08.116011Z","caller":"traceutil/trace.go:171","msg":"trace[1880635443] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"240.957824ms","start":"2026-04-27T01:30:07.875013Z","end":"2026-04-27T01:30:08.115971Z","steps":["trace[1880635443] 'process raft request' (duration: 240.501605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:30:08.116135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.709778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-04-27T01:30:08.116215Z","caller":"traceutil/trace.go:171","msg":"trace[93018057] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:590; }","duration":"237.819119ms","start":"2026-04-27T01:30:07.878382Z","end":"2026-04-27T01:30:08.116201Z","steps":["trace[93018057] 'agreement among raft nodes before linearized reading' (duration: 237.622786ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:08.132123Z","caller":"traceutil/trace.go:171","msg":"trace[2035254464] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"229.513984ms","start":"2026-04-27T01:30:07.902594Z","end":"2026-04-27T01:30:08.132108Z","steps":["trace[2035254464] 'process raft request' (duration: 229.277259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:30:08.132312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.616333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-27T01:30:08.132348Z","caller":"traceutil/trace.go:171","msg":"trace[280181166] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:591; }","duration":"204.682194ms","start":"2026-04-27T01:30:07.927656Z","end":"2026-04-27T01:30:08.132338Z","steps":["trace[280181166] 'agreement among raft nodes before linearized reading' (duration: 204.619333ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:12.538305Z","caller":"traceutil/trace.go:171","msg":"trace[416337693] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"144.635837ms","start":"2026-04-27T01:30:12.393648Z","end":"2026-04-27T01:30:12.538283Z","steps":["trace[416337693] 'process raft request' (duration: 144.211739ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:12.853996Z","caller":"traceutil/trace.go:171","msg":"trace[1049134684] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"168.651861ms","start":"2026-04-27T01:30:12.685318Z","end":"2026-04-27T01:30:12.85397Z","steps":["trace[1049134684] 'read index received' (duration: 154.391224ms)","trace[1049134684] 'applied index is now lower than readState.Index' (duration: 14.259507ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:30:12.854225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.673671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-27T01:30:12.854231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.895456ms","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-27T01:30:12.854313Z","caller":"traceutil/trace.go:171","msg":"trace[1521472386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"167.798823ms","start":"2026-04-27T01:30:12.686492Z","end":"2026-04-27T01:30:12.854291Z","steps":["trace[1521472386] 'agreement among raft nodes before linearized reading' (duration: 167.62557ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:12.854329Z","caller":"traceutil/trace.go:171","msg":"trace[830119774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"169.003218ms","start":"2026-04-27T01:30:12.685301Z","end":"2026-04-27T01:30:12.854304Z","steps":["trace[830119774] 'agreement among raft nodes before linearized reading' (duration: 168.789074ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:12.853992Z","caller":"traceutil/trace.go:171","msg":"trace[1968191323] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"260.164389ms","start":"2026-04-27T01:30:12.593801Z","end":"2026-04-27T01:30:12.853966Z","steps":["trace[1968191323] 'process raft request' (duration: 245.895673ms)","trace[1968191323] 'compare' (duration: 14.133314ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:30:13.009889Z","caller":"traceutil/trace.go:171","msg":"trace[103029431] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"151.663289ms","start":"2026-04-27T01:30:12.858195Z","end":"2026-04-27T01:30:13.009858Z","steps":["trace[103029431] 'process raft request' (duration: 151.524086ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:13.012407Z","caller":"traceutil/trace.go:171","msg":"trace[1991239329] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"145.341861ms","start":"2026-04-27T01:30:12.86704Z","end":"2026-04-27T01:30:13.012381Z","steps":["trace[1991239329] 'read index received' (duration: 142.733119ms)","trace[1991239329] 'applied index is now lower than readState.Index' (duration: 2.607622ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:30:13.012467Z","caller":"traceutil/trace.go:171","msg":"trace[1749922296] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"152.252389ms","start":"2026-04-27T01:30:12.860191Z","end":"2026-04-27T01:30:13.012443Z","steps":["trace[1749922296] 'process raft request' (duration: 152.060166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:30:13.012556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.499315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:30:13.012633Z","caller":"traceutil/trace.go:171","msg":"trace[1017800236] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:623; }","duration":"145.622677ms","start":"2026-04-27T01:30:12.866991Z","end":"2026-04-27T01:30:13.012614Z","steps":["trace[1017800236] 'agreement among raft nodes before linearized reading' (duration: 145.492254ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:57.976823Z","caller":"traceutil/trace.go:171","msg":"trace[494017009] linearizableReadLoop","detail":"{readStateIndex:1968; appliedIndex:1967; }","duration":"392.389486ms","start":"2026-04-27T01:31:57.584376Z","end":"2026-04-27T01:31:57.976766Z","steps":["trace[494017009] 'read index received' (duration: 345.662378ms)","trace[494017009] 'applied index is now lower than readState.Index' (duration: 46.725158ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:57.976863Z","caller":"traceutil/trace.go:171","msg":"trace[268415705] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"430.002319ms","start":"2026-04-27T01:31:57.54682Z","end":"2026-04-27T01:31:57.976823Z","steps":["trace[268415705] 'process raft request' (duration: 383.309752ms)","trace[268415705] 'compare' (duration: 46.394692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:31:57.977316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.908686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8cbdad8f-7863-4691-9366-5a13351ac288\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-27T01:31:57.977378Z","caller":"traceutil/trace.go:171","msg":"trace[873460319] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8cbdad8f-7863-4691-9366-5a13351ac288; range_end:; response_count:1; response_revision:1896; }","duration":"393.048739ms","start":"2026-04-27T01:31:57.584312Z","end":"2026-04-27T01:31:57.97736Z","steps":["trace[873460319] 'agreement among raft nodes before linearized reading' (duration: 392.701072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:57.97734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.63921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-27T01:31:57.97743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:31:57.584278Z","time spent":"393.141091ms","remote":"127.0.0.1:46170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8cbdad8f-7863-4691-9366-5a13351ac288\" "} {"level":"info","ts":"2026-04-27T01:31:57.977571Z","caller":"traceutil/trace.go:171","msg":"trace[790607178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1896; }","duration":"388.909866ms","start":"2026-04-27T01:31:57.588629Z","end":"2026-04-27T01:31:57.977539Z","steps":["trace[790607178] 'agreement among raft nodes before linearized reading' (duration: 388.515967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:57.977654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:31:57.588613Z","time spent":"389.019599ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T01:31:57.977675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:31:57.54678Z","time spent":"430.188733ms","remote":"127.0.0.1:46170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10966,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:31:57.977696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.981267ms","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-27T01:31:57.977802Z","caller":"traceutil/trace.go:171","msg":"trace[2081131270] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1896; }","duration":"389.129451ms","start":"2026-04-27T01:31:57.588652Z","end":"2026-04-27T01:31:57.977782Z","steps":["trace[2081131270] 'agreement among raft nodes before linearized reading' (duration: 388.825013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:57.977857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:31:57.588637Z","time spent":"389.210182ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T01:31:57.980767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.2141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18aa12a7f5a3277a\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-04-27T01:31:57.980876Z","caller":"traceutil/trace.go:171","msg":"trace[598279552] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18aa12a7f5a3277a; range_end:; response_count:1; response_revision:1896; }","duration":"183.375984ms","start":"2026-04-27T01:31:57.797473Z","end":"2026-04-27T01:31:57.980849Z","steps":["trace[598279552] 'agreement among raft nodes before linearized reading' (duration: 180.001904ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:58.360231Z","caller":"traceutil/trace.go:171","msg":"trace[14081639] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"124.308253ms","start":"2026-04-27T01:31:58.235883Z","end":"2026-04-27T01:31:58.360191Z","steps":["trace[14081639] 'process raft request' (duration: 58.106729ms)","trace[14081639] 'compare' (duration: 66.029251ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:41.15971Z","caller":"traceutil/trace.go:171","msg":"trace[1095778011] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"133.77692ms","start":"2026-04-27T01:32:41.025877Z","end":"2026-04-27T01:32:41.159654Z","steps":["trace[1095778011] 'process raft request' (duration: 126.348991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:41.522012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.638756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:32:41.5221Z","caller":"traceutil/trace.go:171","msg":"trace[1444924863] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2191; }","duration":"120.805919ms","start":"2026-04-27T01:32:41.401276Z","end":"2026-04-27T01:32:41.522081Z","steps":["trace[1444924863] 'range keys from in-memory index tree' (duration: 120.547484ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:47.529209Z","caller":"traceutil/trace.go:171","msg":"trace[545709074] linearizableReadLoop","detail":"{readStateIndex:2308; appliedIndex:2307; }","duration":"126.736718ms","start":"2026-04-27T01:32:47.402451Z","end":"2026-04-27T01:32:47.529188Z","steps":["trace[545709074] 'read index received' (duration: 126.516913ms)","trace[545709074] 'applied index is now lower than readState.Index' (duration: 219.035µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:47.529287Z","caller":"traceutil/trace.go:171","msg":"trace[1038844467] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"137.933323ms","start":"2026-04-27T01:32:47.391326Z","end":"2026-04-27T01:32:47.529259Z","steps":["trace[1038844467] 'process raft request' (duration: 137.716829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:47.529324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.86035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:32:47.529361Z","caller":"traceutil/trace.go:171","msg":"trace[1509377788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2224; }","duration":"126.939902ms","start":"2026-04-27T01:32:47.402406Z","end":"2026-04-27T01:32:47.529346Z","steps":["trace[1509377788] 'agreement among raft nodes before linearized reading' (duration: 126.86924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:48.336092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.729567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:32:48.336288Z","caller":"traceutil/trace.go:171","msg":"trace[785554969] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"277.606223ms","start":"2026-04-27T01:32:48.058638Z","end":"2026-04-27T01:32:48.336244Z","steps":["trace[785554969] 'process raft request' (duration: 155.469777ms)","trace[785554969] 'compare' (duration: 121.527344ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:34:08.993817Z","caller":"traceutil/trace.go:171","msg":"trace[309771390] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"127.324741ms","start":"2026-04-27T01:34:08.866459Z","end":"2026-04-27T01:34:08.993784Z","steps":["trace[309771390] 'process raft request' (duration: 127.086547ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:34:08.99408Z","caller":"traceutil/trace.go:171","msg":"trace[3241768] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"126.622177ms","start":"2026-04-27T01:34:08.867421Z","end":"2026-04-27T01:34:08.994044Z","steps":["trace[3241768] 'process raft request' (duration: 126.305451ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:34:09.195595Z","caller":"traceutil/trace.go:171","msg":"trace[1070037456] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"241.668653ms","start":"2026-04-27T01:34:08.953896Z","end":"2026-04-27T01:34:09.195564Z","steps":["trace[1070037456] 'process raft request' (duration: 178.598784ms)","trace[1070037456] 'compare' (duration: 62.921526ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:34:09.20779Z","caller":"traceutil/trace.go:171","msg":"trace[1266766371] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"213.794843ms","start":"2026-04-27T01:34:08.993967Z","end":"2026-04-27T01:34:09.207762Z","steps":["trace[1266766371] 'process raft request' (duration: 213.6463ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:18.086365Z","caller":"traceutil/trace.go:171","msg":"trace[1830770891] linearizableReadLoop","detail":"{readStateIndex:5156; appliedIndex:5155; }","duration":"125.958995ms","start":"2026-04-27T01:38:17.960373Z","end":"2026-04-27T01:38:18.086332Z","steps":["trace[1830770891] 'read index received' (duration: 38.174205ms)","trace[1830770891] 'applied index is now lower than readState.Index' (duration: 87.78282ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:38:18.086631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.237561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-27T01:38:18.086727Z","caller":"traceutil/trace.go:171","msg":"trace[591921761] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4968; }","duration":"126.348004ms","start":"2026-04-27T01:38:17.960356Z","end":"2026-04-27T01:38:18.086704Z","steps":["trace[591921761] 'agreement among raft nodes before linearized reading' (duration: 126.082538ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:18.27313Z","caller":"traceutil/trace.go:171","msg":"trace[417350032] linearizableReadLoop","detail":"{readStateIndex:5160; appliedIndex:5159; }","duration":"100.850322ms","start":"2026-04-27T01:38:18.172258Z","end":"2026-04-27T01:38:18.273108Z","steps":["trace[417350032] 'read index received' (duration: 100.583777ms)","trace[417350032] 'applied index is now lower than readState.Index' (duration: 265.385µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:38:18.273212Z","caller":"traceutil/trace.go:171","msg":"trace[135022827] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"103.940674ms","start":"2026-04-27T01:38:18.169236Z","end":"2026-04-27T01:38:18.273177Z","steps":["trace[135022827] 'process raft request' (duration: 103.669149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:38:18.273394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.103697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-27T01:38:18.273451Z","caller":"traceutil/trace.go:171","msg":"trace[1790133815] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4972; }","duration":"101.194579ms","start":"2026-04-27T01:38:18.172239Z","end":"2026-04-27T01:38:18.273434Z","steps":["trace[1790133815] 'agreement among raft nodes before linearized reading' (duration: 100.952044ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:18.299509Z","caller":"traceutil/trace.go:171","msg":"trace[1993793038] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"102.71263ms","start":"2026-04-27T01:38:18.196775Z","end":"2026-04-27T01:38:18.299488Z","steps":["trace[1993793038] 'process raft request' (duration: 102.315602ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:21.12079Z","caller":"traceutil/trace.go:171","msg":"trace[1106170073] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"108.066478ms","start":"2026-04-27T01:38:21.012703Z","end":"2026-04-27T01:38:21.12077Z","steps":["trace[1106170073] 'process raft request' (duration: 107.920135ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:40.740412Z","caller":"traceutil/trace.go:171","msg":"trace[864252006] transaction","detail":"{read_only:false; response_revision:5501; number_of_response:1; }","duration":"289.502405ms","start":"2026-04-27T01:38:40.450864Z","end":"2026-04-27T01:38:40.740366Z","steps":["trace[864252006] 'process raft request' (duration: 214.847838ms)","trace[864252006] 'compare' (duration: 74.392902ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:38:40.740465Z","caller":"traceutil/trace.go:171","msg":"trace[2115409686] transaction","detail":"{read_only:false; response_revision:5503; number_of_response:1; }","duration":"141.328804ms","start":"2026-04-27T01:38:40.599106Z","end":"2026-04-27T01:38:40.740435Z","steps":["trace[2115409686] 'process raft request' (duration: 141.240862ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:40.740697Z","caller":"traceutil/trace.go:171","msg":"trace[1890768472] linearizableReadLoop","detail":"{readStateIndex:5704; appliedIndex:5702; }","duration":"268.448822ms","start":"2026-04-27T01:38:40.472235Z","end":"2026-04-27T01:38:40.740684Z","steps":["trace[1890768472] 'read index received' (duration: 42.455351ms)","trace[1890768472] 'applied index is now lower than readState.Index' (duration: 225.992401ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:38:40.740661Z","caller":"traceutil/trace.go:171","msg":"trace[1365144421] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"228.162135ms","start":"2026-04-27T01:38:40.512471Z","end":"2026-04-27T01:38:40.740633Z","steps":["trace[1365144421] 'process raft request' (duration: 227.820418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:38:40.740932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.677667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T01:38:40.740944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.517892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-27T01:38:40.74098Z","caller":"traceutil/trace.go:171","msg":"trace[249501850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5503; }","duration":"216.636104ms","start":"2026-04-27T01:38:40.524335Z","end":"2026-04-27T01:38:40.740971Z","steps":["trace[249501850] 'agreement among raft nodes before linearized reading' (duration: 216.46495ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:40.740981Z","caller":"traceutil/trace.go:171","msg":"trace[109673597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5503; }","duration":"268.79212ms","start":"2026-04-27T01:38:40.472173Z","end":"2026-04-27T01:38:40.740965Z","steps":["trace[109673597] 'agreement among raft nodes before linearized reading' (duration: 268.580225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:38:40.741015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.627133ms","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-27T01:38:40.741071Z","caller":"traceutil/trace.go:171","msg":"trace[1300390212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5503; }","duration":"206.716995ms","start":"2026-04-27T01:38:40.534323Z","end":"2026-04-27T01:38:40.74104Z","steps":["trace[1300390212] 'agreement among raft nodes before linearized reading' (duration: 206.532811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:38:40.741012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.410456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ebf2c9ac-e19f-46e3-bdd3-236fd6494aa7\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-27T01:38:40.741133Z","caller":"traceutil/trace.go:171","msg":"trace[521609096] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ebf2c9ac-e19f-46e3-bdd3-236fd6494aa7; range_end:; response_count:1; response_revision:5503; }","duration":"154.58735ms","start":"2026-04-27T01:38:40.586524Z","end":"2026-04-27T01:38:40.741112Z","steps":["trace[521609096] 'agreement among raft nodes before linearized reading' (duration: 154.327354ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:40.977545Z","caller":"traceutil/trace.go:171","msg":"trace[1414402402] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"230.951692ms","start":"2026-04-27T01:38:40.746555Z","end":"2026-04-27T01:38:40.977506Z","steps":["trace[1414402402] 'process raft request' (duration: 230.398661ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:40.977984Z","caller":"traceutil/trace.go:171","msg":"trace[150817888] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"228.707487ms","start":"2026-04-27T01:38:40.749239Z","end":"2026-04-27T01:38:40.977947Z","steps":["trace[150817888] 'process raft request' (duration: 228.494682ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:38:40.978172Z","caller":"traceutil/trace.go:171","msg":"trace[1245109161] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"230.047343ms","start":"2026-04-27T01:38:40.748106Z","end":"2026-04-27T01:38:40.978154Z","steps":["trace[1245109161] 'process raft request' (duration: 229.328008ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:39:35.004712Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000} {"level":"info","ts":"2026-04-27T01:39:35.075656Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"69.361607ms","hash":94931220,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":33288192,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-27T01:39:35.075788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":94931220,"revision":3000,"compact-revision":-1} {"level":"info","ts":"2026-04-27T01:44:35.012983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6019} {"level":"info","ts":"2026-04-27T01:44:35.105841Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6019,"took":"90.927773ms","hash":1059941852,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":21848064,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-27T01:44:35.105916Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1059941852,"revision":6019,"compact-revision":3000} {"level":"info","ts":"2026-04-27T01:44:46.964374Z","caller":"traceutil/trace.go:171","msg":"trace[1389510389] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"272.127184ms","start":"2026-04-27T01:44:46.692221Z","end":"2026-04-27T01:44:46.964348Z","steps":["trace[1389510389] 'process raft request' (duration: 271.979212ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:44:47.071655Z","caller":"traceutil/trace.go:171","msg":"trace[446358310] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"102.163387ms","start":"2026-04-27T01:44:46.969452Z","end":"2026-04-27T01:44:47.071615Z","steps":["trace[446358310] 'process raft request' (duration: 100.32082ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:44:47.071662Z","caller":"traceutil/trace.go:171","msg":"trace[1508456143] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"102.138706ms","start":"2026-04-27T01:44:46.969482Z","end":"2026-04-27T01:44:47.071621Z","steps":["trace[1508456143] 'process raft request' (duration: 102.056184ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:44:58.153345Z","caller":"traceutil/trace.go:171","msg":"trace[3443678] transaction","detail":"{read_only:false; response_revision:8398; number_of_response:1; }","duration":"113.25654ms","start":"2026-04-27T01:44:58.040057Z","end":"2026-04-27T01:44:58.153313Z","steps":["trace[3443678] 'process raft request' (duration: 66.975632ms)","trace[3443678] 'compare' (duration: 46.143835ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:44:58.344554Z","caller":"traceutil/trace.go:171","msg":"trace[2117296013] transaction","detail":"{read_only:false; response_revision:8400; number_of_response:1; }","duration":"122.205308ms","start":"2026-04-27T01:44:58.222319Z","end":"2026-04-27T01:44:58.344524Z","steps":["trace[2117296013] 'process raft request' (duration: 122.009185ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:44:58.35224Z","caller":"traceutil/trace.go:171","msg":"trace[1745263578] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"101.382372ms","start":"2026-04-27T01:44:58.250838Z","end":"2026-04-27T01:44:58.35222Z","steps":["trace[1745263578] 'process raft request' (duration: 101.28051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:45:00.596537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.487768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:45:00.596809Z","caller":"traceutil/trace.go:171","msg":"trace[953737269] transaction","detail":"{read_only:false; response_revision:8412; number_of_response:1; }","duration":"246.486371ms","start":"2026-04-27T01:45:00.350287Z","end":"2026-04-27T01:45:00.596773Z","steps":["trace[953737269] 'process raft request' (duration: 87.633997ms)","trace[953737269] 'compare' (duration: 158.206261ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:45:00.597176Z","caller":"traceutil/trace.go:171","msg":"trace[592700588] transaction","detail":"{read_only:false; response_revision:8413; number_of_response:1; }","duration":"241.138373ms","start":"2026-04-27T01:45:00.356013Z","end":"2026-04-27T01:45:00.597151Z","steps":["trace[592700588] 'process raft request' (duration: 241.010431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:45:00.849574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.986036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:45:00.849686Z","caller":"traceutil/trace.go:171","msg":"trace[1018428955] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8413; }","duration":"138.134228ms","start":"2026-04-27T01:45:00.711511Z","end":"2026-04-27T01:45:00.849646Z","steps":["trace[1018428955] 'range keys from in-memory index tree' (duration: 137.875453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:45:01.284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.77647ms","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-27T01:45:01.284134Z","caller":"traceutil/trace.go:171","msg":"trace[375663123] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8414; }","duration":"109.920564ms","start":"2026-04-27T01:45:01.174195Z","end":"2026-04-27T01:45:01.284116Z","steps":["trace[375663123] 'range keys from in-memory index tree' (duration: 109.76412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:45:28.097708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.078326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-27T01:45:28.097822Z","caller":"traceutil/trace.go:171","msg":"trace[1857488336] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:8611; }","duration":"120.256689ms","start":"2026-04-27T01:45:27.97754Z","end":"2026-04-27T01:45:28.097797Z","steps":["trace[1857488336] 'range keys from in-memory index tree' (duration: 119.842651ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:45:31.446884Z","caller":"traceutil/trace.go:171","msg":"trace[1928431118] linearizableReadLoop","detail":"{readStateIndex:8931; appliedIndex:8930; }","duration":"101.867351ms","start":"2026-04-27T01:45:31.344994Z","end":"2026-04-27T01:45:31.446861Z","steps":["trace[1928431118] 'read index received' (duration: 101.599876ms)","trace[1928431118] 'applied index is now lower than readState.Index' (duration: 266.795µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:45:31.446966Z","caller":"traceutil/trace.go:171","msg":"trace[1244556848] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"205.681101ms","start":"2026-04-27T01:45:31.241252Z","end":"2026-04-27T01:45:31.446933Z","steps":["trace[1244556848] 'process raft request' (duration: 205.441436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:45:31.447107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.093966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-27T01:45:31.447135Z","caller":"traceutil/trace.go:171","msg":"trace[67318938] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8629; }","duration":"102.175237ms","start":"2026-04-27T01:45:31.344952Z","end":"2026-04-27T01:45:31.447128Z","steps":["trace[67318938] 'agreement among raft nodes before linearized reading' (duration: 102.032494ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:45:40.862735Z","caller":"traceutil/trace.go:171","msg":"trace[1114758678] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"149.26556ms","start":"2026-04-27T01:45:40.713443Z","end":"2026-04-27T01:45:40.862708Z","steps":["trace[1114758678] 'process raft request' (duration: 149.060796ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:45:40.862827Z","caller":"traceutil/trace.go:171","msg":"trace[1523431698] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"100.931942ms","start":"2026-04-27T01:45:40.761874Z","end":"2026-04-27T01:45:40.862805Z","steps":["trace[1523431698] 'process raft request' (duration: 100.770769ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:45:41.813441Z","caller":"traceutil/trace.go:171","msg":"trace[721150598] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"146.632737ms","start":"2026-04-27T01:45:41.66677Z","end":"2026-04-27T01:45:41.813403Z","steps":["trace[721150598] 'process raft request' (duration: 96.099195ms)","trace[721150598] 'compare' (duration: 50.307608ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:45:41.813545Z","caller":"traceutil/trace.go:171","msg":"trace[1320449469] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"146.326532ms","start":"2026-04-27T01:45:41.667189Z","end":"2026-04-27T01:45:41.813516Z","steps":["trace[1320449469] 'process raft request' (duration: 146.197199ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:45:57.889727Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ea.wal"} {"level":"info","ts":"2026-04-27T01:46:57.373702Z","caller":"traceutil/trace.go:171","msg":"trace[53978963] transaction","detail":"{read_only:false; response_revision:9466; number_of_response:1; }","duration":"222.6553ms","start":"2026-04-27T01:46:57.151017Z","end":"2026-04-27T01:46:57.373672Z","steps":["trace[53978963] 'process raft request' (duration: 222.474467ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:46:57.413954Z","caller":"traceutil/trace.go:171","msg":"trace[1773248691] transaction","detail":"{read_only:false; response_revision:9467; number_of_response:1; }","duration":"262.700873ms","start":"2026-04-27T01:46:57.151226Z","end":"2026-04-27T01:46:57.413927Z","steps":["trace[1773248691] 'process raft request' (duration: 262.488968ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:47:24.216Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-27T01:47:24.222685Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-27T01:47:24.222894Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-27T01:49:14.115769Z","caller":"traceutil/trace.go:171","msg":"trace[2096658278] transaction","detail":"{read_only:false; response_revision:10512; number_of_response:1; }","duration":"160.776209ms","start":"2026-04-27T01:49:13.954962Z","end":"2026-04-27T01:49:14.115738Z","steps":["trace[2096658278] 'process raft request' (duration: 154.203457ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:49:14.17391Z","caller":"traceutil/trace.go:171","msg":"trace[1862860847] transaction","detail":"{read_only:false; response_revision:10513; number_of_response:1; }","duration":"169.36107ms","start":"2026-04-27T01:49:14.00453Z","end":"2026-04-27T01:49:14.173891Z","steps":["trace[1862860847] 'process raft request' (duration: 169.253228ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:49:35.019491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8140} {"level":"info","ts":"2026-04-27T01:49:35.083291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8140,"took":"61.240596ms","hash":2411201953,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":29552640,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-27T01:49:35.083361Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2411201953,"revision":8140,"compact-revision":6019} {"level":"info","ts":"2026-04-27T01:50:37.555861Z","caller":"traceutil/trace.go:171","msg":"trace[939064414] transaction","detail":"{read_only:false; response_revision:11300; number_of_response:1; }","duration":"137.755634ms","start":"2026-04-27T01:50:37.418067Z","end":"2026-04-27T01:50:37.555822Z","steps":["trace[939064414] 'process raft request' (duration: 128.705844ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:54:35.028251Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10739} {"level":"info","ts":"2026-04-27T01:54:35.102955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10739,"took":"72.750135ms","hash":4271508480,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":27865088,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-27T01:54:35.103041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4271508480,"revision":10739,"compact-revision":8140} {"level":"info","ts":"2026-04-27T01:57:09.015941Z","caller":"traceutil/trace.go:171","msg":"trace[1874060539] transaction","detail":"{read_only:false; response_revision:13921; number_of_response:1; }","duration":"100.082342ms","start":"2026-04-27T01:57:08.915835Z","end":"2026-04-27T01:57:09.015917Z","steps":["trace[1874060539] 'process raft request' (duration: 99.926819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:57:29.427629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.566992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:57:29.427983Z","caller":"traceutil/trace.go:171","msg":"trace[835708621] transaction","detail":"{read_only:false; response_revision:14222; number_of_response:1; }","duration":"149.987521ms","start":"2026-04-27T01:57:29.277981Z","end":"2026-04-27T01:57:29.427968Z","steps":["trace[835708621] 'compare' (duration: 140.484471ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:57:29.428217Z","caller":"traceutil/trace.go:171","msg":"trace[452072336] transaction","detail":"{read_only:false; response_revision:14223; number_of_response:1; }","duration":"149.589984ms","start":"2026-04-27T01:57:29.278608Z","end":"2026-04-27T01:57:29.428198Z","steps":["trace[452072336] 'process raft request' (duration: 149.105703ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:58:55.506468Z","caller":"traceutil/trace.go:171","msg":"trace[370408428] linearizableReadLoop","detail":"{readStateIndex:15541; appliedIndex:15540; }","duration":"102.061523ms","start":"2026-04-27T01:58:55.404362Z","end":"2026-04-27T01:58:55.506424Z","steps":["trace[370408428] 'read index received' (duration: 101.772927ms)","trace[370408428] 'applied index is now lower than readState.Index' (duration: 286.596µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:58:55.506564Z","caller":"traceutil/trace.go:171","msg":"trace[1798869339] transaction","detail":"{read_only:false; response_revision:15030; number_of_response:1; }","duration":"114.645074ms","start":"2026-04-27T01:58:55.391887Z","end":"2026-04-27T01:58:55.506532Z","steps":["trace[1798869339] 'process raft request' (duration: 114.290167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.506847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.46213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-04-27T01:58:55.506931Z","caller":"traceutil/trace.go:171","msg":"trace[1219932655] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15030; }","duration":"102.614234ms","start":"2026-04-27T01:58:55.404299Z","end":"2026-04-27T01:58:55.506913Z","steps":["trace[1219932655] 'agreement among raft nodes before linearized reading' (duration: 102.344408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.511318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.681865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:58:55.511394Z","caller":"traceutil/trace.go:171","msg":"trace[773561379] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15031; }","duration":"105.793317ms","start":"2026-04-27T01:58:55.405589Z","end":"2026-04-27T01:58:55.511382Z","steps":["trace[773561379] 'agreement among raft nodes before linearized reading' (duration: 105.665955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.786098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.769156ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:58:55.78627Z","caller":"traceutil/trace.go:171","msg":"trace[245005747] transaction","detail":"{read_only:false; response_revision:15032; number_of_response:1; }","duration":"270.416591ms","start":"2026-04-27T01:58:55.515814Z","end":"2026-04-27T01:58:55.786231Z","steps":["trace[245005747] 'process raft request' (duration: 133.393209ms)","trace[245005747] 'compare' (duration: 136.267246ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:58:55.786506Z","caller":"traceutil/trace.go:171","msg":"trace[1830825675] linearizableReadLoop","detail":"{readStateIndex:15543; appliedIndex:15542; }","duration":"210.698325ms","start":"2026-04-27T01:58:55.57561Z","end":"2026-04-27T01:58:55.786309Z","steps":["trace[1830825675] 'read index received' (duration: 73.51744ms)","trace[1830825675] 'applied index is now lower than readState.Index' (duration: 137.178025ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:58:55.786616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.95542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:58:55.786687Z","caller":"traceutil/trace.go:171","msg":"trace[1737846530] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15032; }","duration":"211.134924ms","start":"2026-04-27T01:58:55.575539Z","end":"2026-04-27T01:58:55.786674Z","steps":["trace[1737846530] 'agreement among raft nodes before linearized reading' (duration: 210.802558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.786742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.997201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:58:55.786785Z","caller":"traceutil/trace.go:171","msg":"trace[1741261455] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15032; }","duration":"211.084793ms","start":"2026-04-27T01:58:55.575687Z","end":"2026-04-27T01:58:55.786772Z","steps":["trace[1741261455] 'agreement among raft nodes before linearized reading' (duration: 210.971321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.786835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.126724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-27T01:58:55.78686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.016392ms","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-27T01:58:55.786957Z","caller":"traceutil/trace.go:171","msg":"trace[440808317] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15032; }","duration":"119.141055ms","start":"2026-04-27T01:58:55.667795Z","end":"2026-04-27T01:58:55.786936Z","steps":["trace[440808317] 'agreement among raft nodes before linearized reading' (duration: 118.90125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.787061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.883419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-qdpkc\" ","response":"range_response_count:1 size:20766"} {"level":"info","ts":"2026-04-27T01:58:55.787101Z","caller":"traceutil/trace.go:171","msg":"trace[1817308355] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-qdpkc; range_end:; response_count:1; response_revision:15032; }","duration":"128.94404ms","start":"2026-04-27T01:58:55.658148Z","end":"2026-04-27T01:58:55.787092Z","steps":["trace[1817308355] 'agreement among raft nodes before linearized reading' (duration: 128.777976ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:58:55.786898Z","caller":"traceutil/trace.go:171","msg":"trace[886222654] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:15032; }","duration":"137.245426ms","start":"2026-04-27T01:58:55.649634Z","end":"2026-04-27T01:58:55.786879Z","steps":["trace[886222654] 'agreement among raft nodes before linearized reading' (duration: 137.100974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.787486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.445381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-04-27T01:58:55.787609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.851159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:58:55.78766Z","caller":"traceutil/trace.go:171","msg":"trace[720643663] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15032; }","duration":"211.917699ms","start":"2026-04-27T01:58:55.575727Z","end":"2026-04-27T01:58:55.787645Z","steps":["trace[720643663] 'agreement among raft nodes before linearized reading' (duration: 211.851298ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:58:55.788345Z","caller":"traceutil/trace.go:171","msg":"trace[430321198] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15032; }","duration":"209.530802ms","start":"2026-04-27T01:58:55.578006Z","end":"2026-04-27T01:58:55.787537Z","steps":["trace[430321198] 'agreement among raft nodes before linearized reading' (duration: 209.305738ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:58:55.895952Z","caller":"traceutil/trace.go:171","msg":"trace[1775564905] linearizableReadLoop","detail":"{readStateIndex:15544; appliedIndex:15543; }","duration":"100.46931ms","start":"2026-04-27T01:58:55.795457Z","end":"2026-04-27T01:58:55.895926Z","steps":["trace[1775564905] 'read index received' (duration: 100.272747ms)","trace[1775564905] 'applied index is now lower than readState.Index' (duration: 195.523µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:58:55.896142Z","caller":"traceutil/trace.go:171","msg":"trace[1205627933] transaction","detail":"{read_only:false; response_revision:15033; number_of_response:1; }","duration":"103.686905ms","start":"2026-04-27T01:58:55.792422Z","end":"2026-04-27T01:58:55.896109Z","steps":["trace[1205627933] 'process raft request' (duration: 103.336148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:58:55.896961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.48164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737568"} {"level":"info","ts":"2026-04-27T01:58:55.897014Z","caller":"traceutil/trace.go:171","msg":"trace[2017331839] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15033; }","duration":"101.555422ms","start":"2026-04-27T01:58:55.795449Z","end":"2026-04-27T01:58:55.897004Z","steps":["trace[2017331839] 'agreement among raft nodes before linearized reading' (duration: 100.761126ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:59:35.03527Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12837} {"level":"info","ts":"2026-04-27T01:59:35.110171Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12837,"took":"72.181144ms","hash":1631551297,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":30576640,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-27T01:59:35.110291Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1631551297,"revision":12837,"compact-revision":10739} {"level":"info","ts":"2026-04-27T02:04:29.859346Z","caller":"traceutil/trace.go:171","msg":"trace[98074758] transaction","detail":"{read_only:false; response_revision:17595; number_of_response:1; }","duration":"109.801627ms","start":"2026-04-27T02:04:29.749513Z","end":"2026-04-27T02:04:29.859315Z","steps":["trace[98074758] 'process raft request' (duration: 63.323638ms)","trace[98074758] 'compare' (duration: 46.291096ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:04:30.61676Z","caller":"traceutil/trace.go:171","msg":"trace[191211427] linearizableReadLoop","detail":"{readStateIndex:18191; appliedIndex:18190; }","duration":"120.837388ms","start":"2026-04-27T02:04:30.495901Z","end":"2026-04-27T02:04:30.616738Z","steps":["trace[191211427] 'read index received' (duration: 120.649604ms)","trace[191211427] 'applied index is now lower than readState.Index' (duration: 186.954µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:04:30.617029Z","caller":"traceutil/trace.go:171","msg":"trace[427188870] transaction","detail":"{read_only:false; response_revision:17598; number_of_response:1; }","duration":"194.588914ms","start":"2026-04-27T02:04:30.422425Z","end":"2026-04-27T02:04:30.617014Z","steps":["trace[427188870] 'process raft request' (duration: 194.183166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:04:30.618365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.443929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-04-27T02:04:30.618412Z","caller":"traceutil/trace.go:171","msg":"trace[1635171761] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:17598; }","duration":"122.53296ms","start":"2026-04-27T02:04:30.495869Z","end":"2026-04-27T02:04:30.618402Z","steps":["trace[1635171761] 'agreement among raft nodes before linearized reading' (duration: 121.453299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:04:30.618556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.919468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:04:30.618584Z","caller":"traceutil/trace.go:171","msg":"trace[1732687486] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:17598; }","duration":"110.96614ms","start":"2026-04-27T02:04:30.507609Z","end":"2026-04-27T02:04:30.618575Z","steps":["trace[1732687486] 'agreement among raft nodes before linearized reading' (duration: 110.926879ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:04:30.880283Z","caller":"traceutil/trace.go:171","msg":"trace[1355584813] transaction","detail":"{read_only:false; response_revision:17599; number_of_response:1; }","duration":"163.272536ms","start":"2026-04-27T02:04:30.716981Z","end":"2026-04-27T02:04:30.880253Z","steps":["trace[1355584813] 'process raft request' (duration: 163.092683ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:04:30.900832Z","caller":"traceutil/trace.go:171","msg":"trace[1421093311] transaction","detail":"{read_only:false; response_revision:17600; number_of_response:1; }","duration":"180.057042ms","start":"2026-04-27T02:04:30.720746Z","end":"2026-04-27T02:04:30.900803Z","steps":["trace[1421093311] 'process raft request' (duration: 179.887999ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:04:35.042179Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15299} {"level":"info","ts":"2026-04-27T02:04:35.141725Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15299,"took":"97.144813ms","hash":641712127,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":32845824,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-27T02:04:35.141787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":641712127,"revision":15299,"compact-revision":12837} {"level":"info","ts":"2026-04-27T02:07:57.48747Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-27T02:07:57.492734Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-04-27T02:07:57.49297Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-04-27T02:09:35.075123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17693} {"level":"info","ts":"2026-04-27T02:09:35.203035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17693,"took":"124.546953ms","hash":1150026351,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":34312192,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-27T02:09:35.203095Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1150026351,"revision":17693,"compact-revision":15299} {"level":"warn","ts":"2026-04-27T02:10:04.143117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.229601ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-27T02:10:04.14357Z","caller":"traceutil/trace.go:171","msg":"trace[1273135104] linearizableReadLoop","detail":"{readStateIndex:20929; appliedIndex:20928; }","duration":"571.825544ms","start":"2026-04-27T02:10:03.57168Z","end":"2026-04-27T02:10:04.143506Z","steps":["trace[1273135104] 'read index received' (duration: 105.219176ms)","trace[1273135104] 'applied index is now lower than readState.Index' (duration: 466.604798ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:10:04.143794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.08784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-27T02:10:04.143878Z","caller":"traceutil/trace.go:171","msg":"trace[1043080428] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20250; }","duration":"572.215292ms","start":"2026-04-27T02:10:03.571637Z","end":"2026-04-27T02:10:04.143853Z","steps":["trace[1043080428] 'agreement among raft nodes before linearized reading' (duration: 571.963497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:04.14393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:03.571619Z","time spent":"572.302224ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T02:10:04.222306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.715097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:10:04.222381Z","caller":"traceutil/trace.go:171","msg":"trace[1822141813] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:20252; }","duration":"186.84226ms","start":"2026-04-27T02:10:04.035518Z","end":"2026-04-27T02:10:04.222361Z","steps":["trace[1822141813] 'agreement among raft nodes before linearized reading' (duration: 186.710187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:04.842298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566652363403191,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T02:10:05.129446Z","caller":"traceutil/trace.go:171","msg":"trace[2047164605] transaction","detail":"{read_only:false; response_revision:20253; number_of_response:1; }","duration":"980.108244ms","start":"2026-04-27T02:10:04.149301Z","end":"2026-04-27T02:10:05.129409Z","steps":["trace[2047164605] 'process raft request' (duration: 979.844319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.129747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:04.149279Z","time spent":"980.332489ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:10:05.157117Z","caller":"traceutil/trace.go:171","msg":"trace[218213934] transaction","detail":"{read_only:false; response_revision:20254; number_of_response:1; }","duration":"767.155783ms","start":"2026-04-27T02:10:04.389936Z","end":"2026-04-27T02:10:05.157092Z","steps":["trace[218213934] 'process raft request' (duration: 766.938979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.157262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:04.389906Z","time spent":"767.280575ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:10:05.157404Z","caller":"traceutil/trace.go:171","msg":"trace[2043085273] linearizableReadLoop","detail":"{readStateIndex:20934; appliedIndex:20931; }","duration":"815.954299ms","start":"2026-04-27T02:10:04.341385Z","end":"2026-04-27T02:10:05.157339Z","steps":["trace[2043085273] 'read index received' (duration: 787.723174ms)","trace[2043085273] 'applied index is now lower than readState.Index' (duration: 28.227155ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:10:05.157458Z","caller":"traceutil/trace.go:171","msg":"trace[38837281] transaction","detail":"{read_only:false; response_revision:20255; number_of_response:1; }","duration":"709.55558ms","start":"2026-04-27T02:10:04.447862Z","end":"2026-04-27T02:10:05.157417Z","steps":["trace[38837281] 'process raft request' (duration: 709.166602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.157595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.176373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-04-27T02:10:05.157733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.222546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"warn","ts":"2026-04-27T02:10:05.157735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.671532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:10:05.157738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:04.447837Z","time spent":"709.715183ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:10:05.157761Z","caller":"traceutil/trace.go:171","msg":"trace[742035573] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:20255; }","duration":"816.379228ms","start":"2026-04-27T02:10:04.341356Z","end":"2026-04-27T02:10:05.157735Z","steps":["trace[742035573] 'agreement among raft nodes before linearized reading' (duration: 816.136533ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:10:05.157785Z","caller":"traceutil/trace.go:171","msg":"trace[1675718934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20255; }","duration":"755.757434ms","start":"2026-04-27T02:10:04.402016Z","end":"2026-04-27T02:10:05.157774Z","steps":["trace[1675718934] 'agreement among raft nodes before linearized reading' (duration: 755.5779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.157821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:04.341337Z","time spent":"816.466379ms","remote":"127.0.0.1:45096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":31,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:10:05.157765Z","caller":"traceutil/trace.go:171","msg":"trace[2001803735] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:20255; }","duration":"178.291147ms","start":"2026-04-27T02:10:04.979464Z","end":"2026-04-27T02:10:05.157756Z","steps":["trace[2001803735] 'agreement among raft nodes before linearized reading' (duration: 178.222846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.157848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.048143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-27T02:10:05.157919Z","caller":"traceutil/trace.go:171","msg":"trace[1914239473] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20255; }","duration":"169.118645ms","start":"2026-04-27T02:10:04.988791Z","end":"2026-04-27T02:10:05.15791Z","steps":["trace[1914239473] 'agreement among raft nodes before linearized reading' (duration: 168.991262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.15801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.515407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-04-27T02:10:05.15783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:04.40196Z","time spent":"755.860385ms","remote":"127.0.0.1:45954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T02:10:05.158052Z","caller":"traceutil/trace.go:171","msg":"trace[1181565895] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20255; }","duration":"522.592569ms","start":"2026-04-27T02:10:04.635447Z","end":"2026-04-27T02:10:05.15804Z","steps":["trace[1181565895] 'agreement among raft nodes before linearized reading' (duration: 522.402905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.15808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:04.635426Z","time spent":"522.646599ms","remote":"127.0.0.1:46170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-27T02:10:05.693948Z","caller":"traceutil/trace.go:171","msg":"trace[871954285] transaction","detail":"{read_only:false; response_revision:20256; number_of_response:1; }","duration":"532.495607ms","start":"2026-04-27T02:10:05.161426Z","end":"2026-04-27T02:10:05.693921Z","steps":["trace[871954285] 'process raft request' (duration: 482.745581ms)","trace[871954285] 'compare' (duration: 49.304887ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:10:05.69402Z","caller":"traceutil/trace.go:171","msg":"trace[1634409533] transaction","detail":"{read_only:false; response_revision:20257; number_of_response:1; }","duration":"531.258702ms","start":"2026-04-27T02:10:05.162736Z","end":"2026-04-27T02:10:05.693994Z","steps":["trace[1634409533] 'process raft request' (duration: 531.166771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.694149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.161411Z","time spent":"532.603329ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:10:05.694155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.16272Z","time spent":"531.362374ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:10:05.694108Z","caller":"traceutil/trace.go:171","msg":"trace[568211662] linearizableReadLoop","detail":"{readStateIndex:20935; appliedIndex:20934; }","duration":"531.847584ms","start":"2026-04-27T02:10:05.162166Z","end":"2026-04-27T02:10:05.694014Z","steps":["trace[568211662] 'read index received' (duration: 482.022466ms)","trace[568211662] 'applied index is now lower than readState.Index' (duration: 49.818878ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:10:05.694238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.055018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-27T02:10:05.694313Z","caller":"traceutil/trace.go:171","msg":"trace[1202084428] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20257; }","duration":"532.20299ms","start":"2026-04-27T02:10:05.162093Z","end":"2026-04-27T02:10:05.694296Z","steps":["trace[1202084428] 'agreement among raft nodes before linearized reading' (duration: 531.999566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.694358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.162071Z","time spent":"532.278702ms","remote":"127.0.0.1:46170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-27T02:10:05.694514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.941165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-27T02:10:05.694556Z","caller":"traceutil/trace.go:171","msg":"trace[399533443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20257; }","duration":"525.025596ms","start":"2026-04-27T02:10:05.16952Z","end":"2026-04-27T02:10:05.694545Z","steps":["trace[399533443] 'agreement among raft nodes before linearized reading' (duration: 524.839463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.694588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.16951Z","time spent":"525.071508ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T02:10:05.694591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.067888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-39b47590-3077-4795-aa30-364d0f470770\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-04-27T02:10:05.69464Z","caller":"traceutil/trace.go:171","msg":"trace[159582622] range","detail":"{range_begin:/registry/persistentvolumes/pvc-39b47590-3077-4795-aa30-364d0f470770; range_end:; response_count:1; response_revision:20257; }","duration":"532.17438ms","start":"2026-04-27T02:10:05.162449Z","end":"2026-04-27T02:10:05.694624Z","steps":["trace[159582622] 'agreement among raft nodes before linearized reading' (duration: 531.903114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.694738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.162441Z","time spent":"532.263402ms","remote":"127.0.0.1:46130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1317,"request content":"key:\"/registry/persistentvolumes/pvc-39b47590-3077-4795-aa30-364d0f470770\" "} {"level":"warn","ts":"2026-04-27T02:10:05.69475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.094468ms","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-27T02:10:05.694791Z","caller":"traceutil/trace.go:171","msg":"trace[931538087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20257; }","duration":"530.15352ms","start":"2026-04-27T02:10:05.164626Z","end":"2026-04-27T02:10:05.694779Z","steps":["trace[931538087] 'agreement among raft nodes before linearized reading' (duration: 530.017427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:05.694837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.164618Z","time spent":"530.208511ms","remote":"127.0.0.1:46260","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":"info","ts":"2026-04-27T02:10:06.14585Z","caller":"traceutil/trace.go:171","msg":"trace[53999424] transaction","detail":"{read_only:false; response_revision:20258; number_of_response:1; }","duration":"447.016445ms","start":"2026-04-27T02:10:05.698804Z","end":"2026-04-27T02:10:06.14582Z","steps":["trace[53999424] 'process raft request' (duration: 434.490235ms)","trace[53999424] 'compare' (duration: 12.312616ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:10:06.145976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.698777Z","time spent":"447.133488ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:10:06.154579Z","caller":"traceutil/trace.go:171","msg":"trace[657385505] transaction","detail":"{read_only:false; response_revision:20259; number_of_response:1; }","duration":"454.75039ms","start":"2026-04-27T02:10:05.699799Z","end":"2026-04-27T02:10:06.154549Z","steps":["trace[657385505] 'process raft request' (duration: 454.563156ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:10:06.154685Z","caller":"traceutil/trace.go:171","msg":"trace[1037304679] linearizableReadLoop","detail":"{readStateIndex:20938; appliedIndex:20936; }","duration":"403.308372ms","start":"2026-04-27T02:10:05.751343Z","end":"2026-04-27T02:10:06.154652Z","steps":["trace[1037304679] 'read index received' (duration: 381.945785ms)","trace[1037304679] 'applied index is now lower than readState.Index' (duration: 21.360827ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:10:06.154743Z","caller":"traceutil/trace.go:171","msg":"trace[1324594467] transaction","detail":"{read_only:false; response_revision:20260; number_of_response:1; }","duration":"382.019074ms","start":"2026-04-27T02:10:05.772699Z","end":"2026-04-27T02:10:06.154718Z","steps":["trace[1324594467] 'process raft request' (duration: 381.79986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:06.154813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.455535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:10:06.154896Z","caller":"traceutil/trace.go:171","msg":"trace[600714440] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20260; }","duration":"403.646998ms","start":"2026-04-27T02:10:05.751231Z","end":"2026-04-27T02:10:06.154878Z","steps":["trace[600714440] 'agreement among raft nodes before linearized reading' (duration: 403.522706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:10:06.154961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.751167Z","time spent":"403.776121ms","remote":"127.0.0.1:46430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-27T02:10:06.15496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.772673Z","time spent":"382.180828ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:10:06.155002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:10:05.699766Z","time spent":"455.145718ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:13:57.165118Z","caller":"traceutil/trace.go:171","msg":"trace[68057689] linearizableReadLoop","detail":"{readStateIndex:23435; appliedIndex:23434; }","duration":"317.573126ms","start":"2026-04-27T02:13:56.847521Z","end":"2026-04-27T02:13:57.165094Z","steps":["trace[68057689] 'read index received' (duration: 317.465044ms)","trace[68057689] 'applied index is now lower than readState.Index' (duration: 107.192µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:13:57.165167Z","caller":"traceutil/trace.go:171","msg":"trace[457068807] transaction","detail":"{read_only:false; response_revision:22685; number_of_response:1; }","duration":"333.558616ms","start":"2026-04-27T02:13:56.831581Z","end":"2026-04-27T02:13:57.16514Z","steps":["trace[457068807] 'process raft request' (duration: 333.310081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:13:57.165313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.78991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-27T02:13:57.165348Z","caller":"traceutil/trace.go:171","msg":"trace[1260199009] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22685; }","duration":"317.874042ms","start":"2026-04-27T02:13:56.847464Z","end":"2026-04-27T02:13:57.165338Z","steps":["trace[1260199009] 'agreement among raft nodes before linearized reading' (duration: 317.725629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:13:57.165349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:13:56.831565Z","time spent":"333.664328ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:13:57.165377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:13:56.847444Z","time spent":"317.925933ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-27T02:13:57.251509Z","caller":"traceutil/trace.go:171","msg":"trace[1213134474] transaction","detail":"{read_only:false; response_revision:22687; number_of_response:1; }","duration":"268.165837ms","start":"2026-04-27T02:13:56.983318Z","end":"2026-04-27T02:13:57.251484Z","steps":["trace[1213134474] 'process raft request' (duration: 268.111796ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:13:57.251647Z","caller":"traceutil/trace.go:171","msg":"trace[266078398] transaction","detail":"{read_only:false; response_revision:22686; number_of_response:1; }","duration":"268.450652ms","start":"2026-04-27T02:13:56.983165Z","end":"2026-04-27T02:13:57.251616Z","steps":["trace[266078398] 'process raft request' (duration: 268.121066ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:14:35.08216Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20092} {"level":"info","ts":"2026-04-27T02:14:35.190722Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20092,"took":"104.686646ms","hash":2451789939,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":41172992,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-04-27T02:14:35.190827Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2451789939,"revision":20092,"compact-revision":17693} {"level":"warn","ts":"2026-04-27T02:17:18.954945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.253688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:18.95503Z","caller":"traceutil/trace.go:171","msg":"trace[320371127] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:24767; }","duration":"167.39798ms","start":"2026-04-27T02:17:18.78761Z","end":"2026-04-27T02:17:18.955008Z","steps":["trace[320371127] 'count revisions from in-memory index tree' (duration: 167.161146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:19.432153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.686678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:19.432239Z","caller":"traceutil/trace.go:171","msg":"trace[22310276] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:24768; }","duration":"278.834031ms","start":"2026-04-27T02:17:19.153385Z","end":"2026-04-27T02:17:19.432219Z","steps":["trace[22310276] 'count revisions from in-memory index tree' (duration: 278.591046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:19.432584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.753847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:19.432662Z","caller":"traceutil/trace.go:171","msg":"trace[1905943081] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:24768; }","duration":"210.87293ms","start":"2026-04-27T02:17:19.22177Z","end":"2026-04-27T02:17:19.432643Z","steps":["trace[1905943081] 'count revisions from in-memory index tree' (duration: 210.670356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:19.432842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.333179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-27T02:17:19.432884Z","caller":"traceutil/trace.go:171","msg":"trace[288692431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24768; }","duration":"177.41917ms","start":"2026-04-27T02:17:19.255449Z","end":"2026-04-27T02:17:19.432868Z","steps":["trace[288692431] 'range keys from in-memory index tree' (duration: 177.184025ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:19.433115Z","caller":"traceutil/trace.go:171","msg":"trace[2068669069] transaction","detail":"{read_only:false; response_revision:24769; number_of_response:1; }","duration":"149.39125ms","start":"2026-04-27T02:17:19.283699Z","end":"2026-04-27T02:17:19.433091Z","steps":["trace[2068669069] 'process raft request' (duration: 72.962201ms)","trace[2068669069] 'compare' (duration: 75.881918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:19.708581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.045043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:19.708683Z","caller":"traceutil/trace.go:171","msg":"trace[885473990] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"271.875331ms","start":"2026-04-27T02:17:19.436797Z","end":"2026-04-27T02:17:19.708672Z","steps":["trace[885473990] 'process raft request' (duration: 138.667414ms)","trace[885473990] 'compare' (duration: 132.956941ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:19.800707Z","caller":"traceutil/trace.go:171","msg":"trace[217280173] transaction","detail":"{read_only:false; response_revision:24771; number_of_response:1; }","duration":"149.143695ms","start":"2026-04-27T02:17:19.651529Z","end":"2026-04-27T02:17:19.800672Z","steps":["trace[217280173] 'process raft request' (duration: 148.960232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:19.800843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.39087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:19.800928Z","caller":"traceutil/trace.go:171","msg":"trace[1950434394] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:24771; }","duration":"169.512983ms","start":"2026-04-27T02:17:19.631394Z","end":"2026-04-27T02:17:19.800907Z","steps":["trace[1950434394] 'agreement among raft nodes before linearized reading' (duration: 169.276337ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:20.139173Z","caller":"traceutil/trace.go:171","msg":"trace[2070444740] linearizableReadLoop","detail":"{readStateIndex:25577; appliedIndex:25576; }","duration":"185.592024ms","start":"2026-04-27T02:17:19.953558Z","end":"2026-04-27T02:17:20.13915Z","steps":["trace[2070444740] 'read index received' (duration: 185.468581ms)","trace[2070444740] 'applied index is now lower than readState.Index' (duration: 122.563µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:20.139273Z","caller":"traceutil/trace.go:171","msg":"trace[1682203386] transaction","detail":"{read_only:false; response_revision:24772; number_of_response:1; }","duration":"192.40591ms","start":"2026-04-27T02:17:19.946857Z","end":"2026-04-27T02:17:20.139263Z","steps":["trace[1682203386] 'process raft request' (duration: 192.153335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.139413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.85079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"info","ts":"2026-04-27T02:17:20.139474Z","caller":"traceutil/trace.go:171","msg":"trace[1054720020] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:24772; }","duration":"185.960371ms","start":"2026-04-27T02:17:19.953497Z","end":"2026-04-27T02:17:20.139457Z","steps":["trace[1054720020] 'agreement among raft nodes before linearized reading' (duration: 185.774737ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:20.408982Z","caller":"traceutil/trace.go:171","msg":"trace[703792479] linearizableReadLoop","detail":"{readStateIndex:25579; appliedIndex:25577; }","duration":"269.725448ms","start":"2026-04-27T02:17:20.139237Z","end":"2026-04-27T02:17:20.408962Z","steps":["trace[703792479] 'read index received' (duration: 265.563195ms)","trace[703792479] 'applied index is now lower than readState.Index' (duration: 4.161473ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:20.409028Z","caller":"traceutil/trace.go:171","msg":"trace[17752769] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"364.960514ms","start":"2026-04-27T02:17:20.044039Z","end":"2026-04-27T02:17:20.409Z","steps":["trace[17752769] 'process raft request' (duration: 364.868182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.102347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:20.409147Z","caller":"traceutil/trace.go:171","msg":"trace[689896981] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:24774; }","duration":"378.189469ms","start":"2026-04-27T02:17:20.030949Z","end":"2026-04-27T02:17:20.409139Z","steps":["trace[689896981] 'agreement among raft nodes before linearized reading' (duration: 378.129947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:20.044026Z","time spent":"365.072277ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:20.409173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:20.030929Z","time spent":"378.238099ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:20.409174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.645107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-27T02:17:20.409241Z","caller":"traceutil/trace.go:171","msg":"trace[400093928] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24774; }","duration":"312.736529ms","start":"2026-04-27T02:17:20.096486Z","end":"2026-04-27T02:17:20.409223Z","steps":["trace[400093928] 'agreement among raft nodes before linearized reading' (duration: 312.527435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.40929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:20.096473Z","time spent":"312.80615ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T02:17:20.409323Z","caller":"traceutil/trace.go:171","msg":"trace[862087808] transaction","detail":"{read_only:false; response_revision:24773; number_of_response:1; }","duration":"373.284701ms","start":"2026-04-27T02:17:20.036032Z","end":"2026-04-27T02:17:20.409317Z","steps":["trace[862087808] 'process raft request' (duration: 368.852292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:20.036001Z","time spent":"373.342023ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:20.409363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.518945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:20.40929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.450232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2e8a8d97-0c36-4871-acd8-8e80072d5e6a\" ","response":"range_response_count:1 size:1316"} {"level":"info","ts":"2026-04-27T02:17:20.409401Z","caller":"traceutil/trace.go:171","msg":"trace[209105873] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24774; }","duration":"392.582256ms","start":"2026-04-27T02:17:20.016802Z","end":"2026-04-27T02:17:20.409384Z","steps":["trace[209105873] 'agreement among raft nodes before linearized reading' (duration: 392.537546ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:20.409411Z","caller":"traceutil/trace.go:171","msg":"trace[2104063247] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2e8a8d97-0c36-4871-acd8-8e80072d5e6a; range_end:; response_count:1; response_revision:24774; }","duration":"266.605955ms","start":"2026-04-27T02:17:20.142798Z","end":"2026-04-27T02:17:20.409404Z","steps":["trace[2104063247] 'agreement among raft nodes before linearized reading' (duration: 266.36625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.030022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:20.409453Z","caller":"traceutil/trace.go:171","msg":"trace[1867490760] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24774; }","duration":"157.060143ms","start":"2026-04-27T02:17:20.252384Z","end":"2026-04-27T02:17:20.409444Z","steps":["trace[1867490760] 'agreement among raft nodes before linearized reading' (duration: 157.014942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.289188ms","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-27T02:17:20.409512Z","caller":"traceutil/trace.go:171","msg":"trace[1878485730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24774; }","duration":"163.313309ms","start":"2026-04-27T02:17:20.246193Z","end":"2026-04-27T02:17:20.409506Z","steps":["trace[1878485730] 'agreement among raft nodes before linearized reading' (duration: 163.250848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:20.016782Z","time spent":"392.640677ms","remote":"127.0.0.1:46184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-27T02:17:20.409609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.682646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-27T02:17:20.40963Z","caller":"traceutil/trace.go:171","msg":"trace[1619963337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24774; }","duration":"163.729587ms","start":"2026-04-27T02:17:20.245895Z","end":"2026-04-27T02:17:20.409625Z","steps":["trace[1619963337] 'agreement among raft nodes before linearized reading' (duration: 163.676136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.314357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:20.409671Z","caller":"traceutil/trace.go:171","msg":"trace[1184376211] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24774; }","duration":"116.362579ms","start":"2026-04-27T02:17:20.293302Z","end":"2026-04-27T02:17:20.409665Z","steps":["trace[1184376211] 'agreement among raft nodes before linearized reading' (duration: 116.316148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.409772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.547293ms","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-27T02:17:20.409797Z","caller":"traceutil/trace.go:171","msg":"trace[1561671001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24774; }","duration":"178.607674ms","start":"2026-04-27T02:17:20.231181Z","end":"2026-04-27T02:17:20.409789Z","steps":["trace[1561671001] 'agreement among raft nodes before linearized reading' (duration: 178.550183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.701033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.494863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:20.701205Z","caller":"traceutil/trace.go:171","msg":"trace[820970910] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"287.486824ms","start":"2026-04-27T02:17:20.4137Z","end":"2026-04-27T02:17:20.701187Z","steps":["trace[820970910] 'process raft request' (duration: 139.772468ms)","trace[820970910] 'compare' (duration: 147.39742ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:20.701419Z","caller":"traceutil/trace.go:171","msg":"trace[501222122] transaction","detail":"{read_only:false; response_revision:24777; number_of_response:1; }","duration":"286.381091ms","start":"2026-04-27T02:17:20.41503Z","end":"2026-04-27T02:17:20.701411Z","steps":["trace[501222122] 'process raft request' (duration: 286.115126ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:20.701451Z","caller":"traceutil/trace.go:171","msg":"trace[1054046674] transaction","detail":"{read_only:false; response_revision:24778; number_of_response:1; }","duration":"286.33194ms","start":"2026-04-27T02:17:20.415102Z","end":"2026-04-27T02:17:20.701434Z","steps":["trace[1054046674] 'process raft request' (duration: 286.229648ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:20.701693Z","caller":"traceutil/trace.go:171","msg":"trace[508082271] linearizableReadLoop","detail":"{readStateIndex:25583; appliedIndex:25580; }","duration":"247.88473ms","start":"2026-04-27T02:17:20.453771Z","end":"2026-04-27T02:17:20.701655Z","steps":["trace[508082271] 'read index received' (duration: 99.684174ms)","trace[508082271] 'applied index is now lower than readState.Index' (duration: 148.197996ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:20.701906Z","caller":"traceutil/trace.go:171","msg":"trace[1331628974] transaction","detail":"{read_only:false; response_revision:24779; number_of_response:1; }","duration":"164.070553ms","start":"2026-04-27T02:17:20.537821Z","end":"2026-04-27T02:17:20.701891Z","steps":["trace[1331628974] 'process raft request' (duration: 163.580083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:20.7019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.116905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18419"} {"level":"info","ts":"2026-04-27T02:17:20.702074Z","caller":"traceutil/trace.go:171","msg":"trace[1502205807] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24778; }","duration":"248.311429ms","start":"2026-04-27T02:17:20.453743Z","end":"2026-04-27T02:17:20.702055Z","steps":["trace[1502205807] 'agreement among raft nodes before linearized reading' (duration: 248.011203ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:26.293377Z","caller":"traceutil/trace.go:171","msg":"trace[915380128] transaction","detail":"{read_only:false; response_revision:24815; number_of_response:1; }","duration":"131.729926ms","start":"2026-04-27T02:17:26.161609Z","end":"2026-04-27T02:17:26.293338Z","steps":["trace[915380128] 'process raft request' (duration: 131.457111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:26.733259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.090794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:26.733382Z","caller":"traceutil/trace.go:171","msg":"trace[2096209005] linearizableReadLoop","detail":"{readStateIndex:25623; appliedIndex:25622; }","duration":"264.018654ms","start":"2026-04-27T02:17:26.469337Z","end":"2026-04-27T02:17:26.733355Z","steps":["trace[2096209005] 'read index received' (duration: 124.746977ms)","trace[2096209005] 'applied index is now lower than readState.Index' (duration: 139.269787ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:26.733693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.35535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:26.733748Z","caller":"traceutil/trace.go:171","msg":"trace[376338358] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24817; }","duration":"264.442161ms","start":"2026-04-27T02:17:26.46929Z","end":"2026-04-27T02:17:26.733732Z","steps":["trace[376338358] 'agreement among raft nodes before linearized reading' (duration: 264.35342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:26.733802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.274688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-27T02:17:26.733894Z","caller":"traceutil/trace.go:171","msg":"trace[207184734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24817; }","duration":"251.4012ms","start":"2026-04-27T02:17:26.482471Z","end":"2026-04-27T02:17:26.733872Z","steps":["trace[207184734] 'agreement among raft nodes before linearized reading' (duration: 251.154805ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:26.733978Z","caller":"traceutil/trace.go:171","msg":"trace[259449548] transaction","detail":"{read_only:false; response_revision:24817; number_of_response:1; }","duration":"301.489543ms","start":"2026-04-27T02:17:26.432473Z","end":"2026-04-27T02:17:26.733962Z","steps":["trace[259449548] 'process raft request' (duration: 161.584363ms)","trace[259449548] 'compare' (duration: 138.613275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:26.734054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:26.43246Z","time spent":"301.558104ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:26.933834Z","caller":"traceutil/trace.go:171","msg":"trace[1754687946] transaction","detail":"{read_only:false; response_revision:24818; number_of_response:1; }","duration":"193.265098ms","start":"2026-04-27T02:17:26.740533Z","end":"2026-04-27T02:17:26.933798Z","steps":["trace[1754687946] 'process raft request' (duration: 111.43926ms)","trace[1754687946] 'compare' (duration: 81.592683ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:26.933893Z","caller":"traceutil/trace.go:171","msg":"trace[2127900746] transaction","detail":"{read_only:false; response_revision:24819; number_of_response:1; }","duration":"193.320049ms","start":"2026-04-27T02:17:26.740549Z","end":"2026-04-27T02:17:26.933869Z","steps":["trace[2127900746] 'process raft request' (duration: 193.189167ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:26.934328Z","caller":"traceutil/trace.go:171","msg":"trace[241594398] linearizableReadLoop","detail":"{readStateIndex:25627; appliedIndex:25623; }","duration":"191.794579ms","start":"2026-04-27T02:17:26.742509Z","end":"2026-04-27T02:17:26.934304Z","steps":["trace[241594398] 'read index received' (duration: 109.475562ms)","trace[241594398] 'applied index is now lower than readState.Index' (duration: 82.317877ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:26.934389Z","caller":"traceutil/trace.go:171","msg":"trace[1168367893] transaction","detail":"{read_only:false; response_revision:24820; number_of_response:1; }","duration":"193.800868ms","start":"2026-04-27T02:17:26.740573Z","end":"2026-04-27T02:17:26.934374Z","steps":["trace[1168367893] 'process raft request' (duration: 193.255157ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:26.93445Z","caller":"traceutil/trace.go:171","msg":"trace[834528005] transaction","detail":"{read_only:false; response_revision:24821; number_of_response:1; }","duration":"193.644235ms","start":"2026-04-27T02:17:26.740791Z","end":"2026-04-27T02:17:26.934436Z","steps":["trace[834528005] 'process raft request' (duration: 193.425371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:26.934562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.042994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T02:17:26.934606Z","caller":"traceutil/trace.go:171","msg":"trace[1950199586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24821; }","duration":"192.167186ms","start":"2026-04-27T02:17:26.742427Z","end":"2026-04-27T02:17:26.934594Z","steps":["trace[1950199586] 'agreement among raft nodes before linearized reading' (duration: 192.013223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:26.934699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.694836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-27T02:17:26.93474Z","caller":"traceutil/trace.go:171","msg":"trace[1003174176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24821; }","duration":"191.747717ms","start":"2026-04-27T02:17:26.742981Z","end":"2026-04-27T02:17:26.934728Z","steps":["trace[1003174176] 'agreement among raft nodes before linearized reading' (duration: 191.562353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:26.934796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.93498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:26.934842Z","caller":"traceutil/trace.go:171","msg":"trace[1548553534] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:24821; }","duration":"158.028062ms","start":"2026-04-27T02:17:26.7768Z","end":"2026-04-27T02:17:26.934828Z","steps":["trace[1548553534] 'agreement among raft nodes before linearized reading' (duration: 157.952381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:26.934881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.489962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-27T02:17:26.934914Z","caller":"traceutil/trace.go:171","msg":"trace[47475875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24821; }","duration":"190.540474ms","start":"2026-04-27T02:17:26.744366Z","end":"2026-04-27T02:17:26.934906Z","steps":["trace[47475875] 'agreement among raft nodes before linearized reading' (duration: 190.458572ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:27.114084Z","caller":"traceutil/trace.go:171","msg":"trace[1791609749] transaction","detail":"{read_only:false; response_revision:24822; number_of_response:1; }","duration":"173.4118ms","start":"2026-04-27T02:17:26.940648Z","end":"2026-04-27T02:17:27.11406Z","steps":["trace[1791609749] 'process raft request' (duration: 142.096734ms)","trace[1791609749] 'compare' (duration: 31.152563ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:27.116488Z","caller":"traceutil/trace.go:171","msg":"trace[1792715804] transaction","detail":"{read_only:false; response_revision:24823; number_of_response:1; }","duration":"175.766658ms","start":"2026-04-27T02:17:26.940685Z","end":"2026-04-27T02:17:27.116452Z","steps":["trace[1792715804] 'process raft request' (duration: 175.580064ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:27.116623Z","caller":"traceutil/trace.go:171","msg":"trace[1218499607] transaction","detail":"{read_only:false; response_revision:24824; number_of_response:1; }","duration":"175.801268ms","start":"2026-04-27T02:17:26.9408Z","end":"2026-04-27T02:17:27.116602Z","steps":["trace[1218499607] 'process raft request' (duration: 175.560563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:27.921611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.4053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:27.921775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.88471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-27T02:17:27.921832Z","caller":"traceutil/trace.go:171","msg":"trace[31238565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24826; }","duration":"179.956631ms","start":"2026-04-27T02:17:27.741857Z","end":"2026-04-27T02:17:27.921814Z","steps":["trace[31238565] 'range keys from in-memory index tree' (duration: 179.761697ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:27.921778Z","caller":"traceutil/trace.go:171","msg":"trace[1000313708] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:24826; }","duration":"121.628224ms","start":"2026-04-27T02:17:27.800128Z","end":"2026-04-27T02:17:27.921757Z","steps":["trace[1000313708] 'count revisions from in-memory index tree' (duration: 121.324668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:27.921668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.963591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7533"} {"level":"info","ts":"2026-04-27T02:17:27.922134Z","caller":"traceutil/trace.go:171","msg":"trace[160341878] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:24826; }","duration":"199.431732ms","start":"2026-04-27T02:17:27.722637Z","end":"2026-04-27T02:17:27.922069Z","steps":["trace[160341878] 'range keys from in-memory index tree' (duration: 198.800489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:28.237292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.841259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-04-27T02:17:28.23731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.813257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-04-27T02:17:28.237375Z","caller":"traceutil/trace.go:171","msg":"trace[1618639332] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:24828; }","duration":"157.948111ms","start":"2026-04-27T02:17:28.079405Z","end":"2026-04-27T02:17:28.237353Z","steps":["trace[1618639332] 'count revisions from in-memory index tree' (duration: 157.797528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:28.237362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.691107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:28.237406Z","caller":"traceutil/trace.go:171","msg":"trace[386242435] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:24828; }","duration":"132.9308ms","start":"2026-04-27T02:17:28.104454Z","end":"2026-04-27T02:17:28.237385Z","steps":["trace[386242435] 'range keys from in-memory index tree' (duration: 132.676785ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:28.237443Z","caller":"traceutil/trace.go:171","msg":"trace[2012530443] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:24828; }","duration":"195.808739ms","start":"2026-04-27T02:17:28.041612Z","end":"2026-04-27T02:17:28.237421Z","steps":["trace[2012530443] 'count revisions from in-memory index tree' (duration: 195.619835ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:28.521505Z","caller":"traceutil/trace.go:171","msg":"trace[1687952126] linearizableReadLoop","detail":"{readStateIndex:25637; appliedIndex:25636; }","duration":"119.793357ms","start":"2026-04-27T02:17:28.401685Z","end":"2026-04-27T02:17:28.521478Z","steps":["trace[1687952126] 'read index received' (duration: 106.009912ms)","trace[1687952126] 'applied index is now lower than readState.Index' (duration: 13.781545ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:28.521721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.008932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:28.521864Z","caller":"traceutil/trace.go:171","msg":"trace[1272797611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24831; }","duration":"120.168235ms","start":"2026-04-27T02:17:28.401644Z","end":"2026-04-27T02:17:28.521812Z","steps":["trace[1272797611] 'agreement among raft nodes before linearized reading' (duration: 119.951531ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:28.521683Z","caller":"traceutil/trace.go:171","msg":"trace[372338669] transaction","detail":"{read_only:false; response_revision:24830; number_of_response:1; }","duration":"149.664485ms","start":"2026-04-27T02:17:28.371743Z","end":"2026-04-27T02:17:28.521408Z","steps":["trace[372338669] 'process raft request' (duration: 135.932731ms)","trace[372338669] 'compare' (duration: 13.595242ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:28.679292Z","caller":"traceutil/trace.go:171","msg":"trace[876167297] transaction","detail":"{read_only:false; response_revision:24832; number_of_response:1; }","duration":"146.135315ms","start":"2026-04-27T02:17:28.533122Z","end":"2026-04-27T02:17:28.679258Z","steps":["trace[876167297] 'process raft request' (duration: 145.947161ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:28.67945Z","caller":"traceutil/trace.go:171","msg":"trace[729294224] linearizableReadLoop","detail":"{readStateIndex:25639; appliedIndex:25638; }","duration":"144.834649ms","start":"2026-04-27T02:17:28.53437Z","end":"2026-04-27T02:17:28.679205Z","steps":["trace[729294224] 'read index received' (duration: 144.624515ms)","trace[729294224] 'applied index is now lower than readState.Index' (duration: 209.354µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:28.679757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.356979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-04-27T02:17:28.679855Z","caller":"traceutil/trace.go:171","msg":"trace[374525830] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:24832; }","duration":"145.503622ms","start":"2026-04-27T02:17:28.534329Z","end":"2026-04-27T02:17:28.679833Z","steps":["trace[374525830] 'agreement among raft nodes before linearized reading' (duration: 145.154895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:28.67999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.294417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:28.680069Z","caller":"traceutil/trace.go:171","msg":"trace[1037149225] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24832; }","duration":"100.42705ms","start":"2026-04-27T02:17:28.579629Z","end":"2026-04-27T02:17:28.680056Z","steps":["trace[1037149225] 'agreement among raft nodes before linearized reading' (duration: 100.258117ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:28.978121Z","caller":"traceutil/trace.go:171","msg":"trace[1426228189] transaction","detail":"{read_only:false; response_revision:24833; number_of_response:1; }","duration":"292.293049ms","start":"2026-04-27T02:17:28.685811Z","end":"2026-04-27T02:17:28.978104Z","steps":["trace[1426228189] 'process raft request' (duration: 284.375881ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:29.004686Z","caller":"traceutil/trace.go:171","msg":"trace[498568115] transaction","detail":"{read_only:false; response_revision:24834; number_of_response:1; }","duration":"264.734508ms","start":"2026-04-27T02:17:28.739902Z","end":"2026-04-27T02:17:29.004637Z","steps":["trace[498568115] 'process raft request' (duration: 264.483443ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:29.171545Z","caller":"traceutil/trace.go:171","msg":"trace[1251905184] transaction","detail":"{read_only:false; response_revision:24838; number_of_response:1; }","duration":"158.183716ms","start":"2026-04-27T02:17:29.013331Z","end":"2026-04-27T02:17:29.171514Z","steps":["trace[1251905184] 'process raft request' (duration: 92.251816ms)","trace[1251905184] 'compare' (duration: 65.486381ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:29.480387Z","caller":"traceutil/trace.go:171","msg":"trace[1426989294] transaction","detail":"{read_only:false; response_revision:24839; number_of_response:1; }","duration":"359.975445ms","start":"2026-04-27T02:17:29.120376Z","end":"2026-04-27T02:17:29.480352Z","steps":["trace[1426989294] 'process raft request' (duration: 341.102617ms)","trace[1426989294] 'compare' (duration: 18.451069ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:29.480545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:29.120359Z","time spent":"360.100267ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:29.48056Z","caller":"traceutil/trace.go:171","msg":"trace[286233570] linearizableReadLoop","detail":"{readStateIndex:25646; appliedIndex:25645; }","duration":"309.358511ms","start":"2026-04-27T02:17:29.17118Z","end":"2026-04-27T02:17:29.480539Z","steps":["trace[286233570] 'read index received' (duration: 290.31605ms)","trace[286233570] 'applied index is now lower than readState.Index' (duration: 19.041421ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:29.480653Z","caller":"traceutil/trace.go:171","msg":"trace[171531245] transaction","detail":"{read_only:false; response_revision:24840; number_of_response:1; }","duration":"300.914762ms","start":"2026-04-27T02:17:29.179728Z","end":"2026-04-27T02:17:29.480643Z","steps":["trace[171531245] 'process raft request' (duration: 300.543515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:29.480737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:29.179705Z","time spent":"300.966804ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:29.481213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.253059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T02:17:29.481262Z","caller":"traceutil/trace.go:171","msg":"trace[1163022384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24841; }","duration":"360.328631ms","start":"2026-04-27T02:17:29.120921Z","end":"2026-04-27T02:17:29.481249Z","steps":["trace[1163022384] 'agreement among raft nodes before linearized reading' (duration: 360.119717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:29.48129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:29.120906Z","time spent":"360.378492ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T02:17:29.481473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.483524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-27T02:17:29.481529Z","caller":"traceutil/trace.go:171","msg":"trace[1875980175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24841; }","duration":"360.608236ms","start":"2026-04-27T02:17:29.120907Z","end":"2026-04-27T02:17:29.481515Z","steps":["trace[1875980175] 'agreement among raft nodes before linearized reading' (duration: 360.429413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:29.481571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:29.120891Z","time spent":"360.671517ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-27T02:17:29.70671Z","caller":"traceutil/trace.go:171","msg":"trace[1897617383] transaction","detail":"{read_only:false; response_revision:24843; number_of_response:1; }","duration":"218.651476ms","start":"2026-04-27T02:17:29.488038Z","end":"2026-04-27T02:17:29.70669Z","steps":["trace[1897617383] 'process raft request' (duration: 174.894199ms)","trace[1897617383] 'compare' (duration: 43.661095ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:30.263946Z","caller":"traceutil/trace.go:171","msg":"trace[911315767] linearizableReadLoop","detail":"{readStateIndex:25652; appliedIndex:25651; }","duration":"257.88065ms","start":"2026-04-27T02:17:30.006038Z","end":"2026-04-27T02:17:30.263918Z","steps":["trace[911315767] 'read index received' (duration: 256.184677ms)","trace[911315767] 'applied index is now lower than readState.Index' (duration: 1.694983ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:30.264132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.071046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:30.264179Z","caller":"traceutil/trace.go:171","msg":"trace[2069348282] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:24845; }","duration":"258.156757ms","start":"2026-04-27T02:17:30.006011Z","end":"2026-04-27T02:17:30.264168Z","steps":["trace[2069348282] 'agreement among raft nodes before linearized reading' (duration: 258.014744ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:30.264395Z","caller":"traceutil/trace.go:171","msg":"trace[2031457233] transaction","detail":"{read_only:false; response_revision:24845; number_of_response:1; }","duration":"300.013614ms","start":"2026-04-27T02:17:29.964353Z","end":"2026-04-27T02:17:30.264367Z","steps":["trace[2031457233] 'process raft request' (duration: 297.943592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:30.264583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:29.964342Z","time spent":"300.136056ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:30.571076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.542473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:30.571515Z","caller":"traceutil/trace.go:171","msg":"trace[1562572120] transaction","detail":"{read_only:false; response_revision:24846; number_of_response:1; }","duration":"179.442071ms","start":"2026-04-27T02:17:30.392049Z","end":"2026-04-27T02:17:30.571491Z","steps":["trace[1562572120] 'process raft request' (duration: 32.383258ms)","trace[1562572120] 'compare' (duration: 146.362759ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:31.081152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.847262ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:31.081258Z","caller":"traceutil/trace.go:171","msg":"trace[1364501382] linearizableReadLoop","detail":"{readStateIndex:25655; appliedIndex:25654; }","duration":"471.115768ms","start":"2026-04-27T02:17:30.610127Z","end":"2026-04-27T02:17:31.081243Z","steps":["trace[1364501382] 'read index received' (duration: 64.075463ms)","trace[1364501382] 'applied index is now lower than readState.Index' (duration: 407.038845ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:31.081303Z","caller":"traceutil/trace.go:171","msg":"trace[164755447] transaction","detail":"{read_only:false; response_revision:24848; number_of_response:1; }","duration":"489.491725ms","start":"2026-04-27T02:17:30.591775Z","end":"2026-04-27T02:17:31.081267Z","steps":["trace[164755447] 'process raft request' (duration: 82.422699ms)","trace[164755447] 'compare' (duration: 406.332521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:31.081403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:30.591754Z","time spent":"489.596527ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":931,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:31.081527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.397294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-04-27T02:17:31.081565Z","caller":"traceutil/trace.go:171","msg":"trace[1468886215] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24848; }","duration":"471.474995ms","start":"2026-04-27T02:17:30.61008Z","end":"2026-04-27T02:17:31.081555Z","steps":["trace[1468886215] 'agreement among raft nodes before linearized reading' (duration: 471.231631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:31.081595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:30.610063Z","time spent":"471.524966ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":556,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-27T02:17:31.582158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566652363415351,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T02:17:31.598962Z","caller":"traceutil/trace.go:171","msg":"trace[584766011] transaction","detail":"{read_only:false; response_revision:24849; number_of_response:1; }","duration":"589.040247ms","start":"2026-04-27T02:17:31.009889Z","end":"2026-04-27T02:17:31.59893Z","steps":["trace[584766011] 'process raft request' (duration: 587.316913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:31.599197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.009864Z","time spent":"589.187361ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:31.99619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.93926ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:31.996692Z","caller":"traceutil/trace.go:171","msg":"trace[127809148] transaction","detail":"{read_only:false; response_revision:24850; number_of_response:1; }","duration":"986.38469ms","start":"2026-04-27T02:17:31.010281Z","end":"2026-04-27T02:17:31.996666Z","steps":["trace[127809148] 'process raft request' (duration: 853.867689ms)","trace[127809148] 'compare' (duration: 131.279217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:31.996845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.010253Z","time spent":"986.502422ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:31.99697Z","caller":"traceutil/trace.go:171","msg":"trace[1056884940] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"982.686847ms","start":"2026-04-27T02:17:31.014037Z","end":"2026-04-27T02:17:31.996724Z","steps":["trace[1056884940] 'process raft request' (duration: 982.534844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:31.997139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.014027Z","time spent":"983.064834ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:31.996961Z","caller":"traceutil/trace.go:171","msg":"trace[402284758] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"982.808859ms","start":"2026-04-27T02:17:31.014134Z","end":"2026-04-27T02:17:31.996942Z","steps":["trace[402284758] 'process raft request' (duration: 982.534213ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:31.997253Z","caller":"traceutil/trace.go:171","msg":"trace[854934697] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"620.741672ms","start":"2026-04-27T02:17:31.376481Z","end":"2026-04-27T02:17:31.997223Z","steps":["trace[854934697] 'process raft request' (duration: 620.475007ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:31.997259Z","caller":"traceutil/trace.go:171","msg":"trace[1022426133] linearizableReadLoop","detail":"{readStateIndex:25662; appliedIndex:25655; }","duration":"915.94163ms","start":"2026-04-27T02:17:31.081289Z","end":"2026-04-27T02:17:31.997231Z","steps":["trace[1022426133] 'read index received' (duration: 515.911184ms)","trace[1022426133] 'applied index is now lower than readState.Index' (duration: 400.029306ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:31.997291Z","caller":"traceutil/trace.go:171","msg":"trace[208374811] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"508.053817ms","start":"2026-04-27T02:17:31.489217Z","end":"2026-04-27T02:17:31.997271Z","steps":["trace[208374811] 'process raft request' (duration: 507.917685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:31.997319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008437581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:31.997318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.014115Z","time spent":"983.138335ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:31.997356Z","caller":"traceutil/trace.go:171","msg":"trace[1519953388] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:24855; }","duration":"1.008517913s","start":"2026-04-27T02:17:30.98883Z","end":"2026-04-27T02:17:31.997348Z","steps":["trace[1519953388] 'agreement among raft nodes before linearized reading' (duration: 1.008442941s)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:31.997004Z","caller":"traceutil/trace.go:171","msg":"trace[1855567794] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"910.763857ms","start":"2026-04-27T02:17:31.086222Z","end":"2026-04-27T02:17:31.996986Z","steps":["trace[1855567794] 'process raft request' (duration: 910.626264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:31.99738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:30.988814Z","time spent":"1.008559793s","remote":"127.0.0.1:60166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:31.997389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.489201Z","time spent":"508.142919ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:31.997402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.376457Z","time spent":"620.862544ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:31.997555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.190792561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-04-27T02:17:31.997451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.086195Z","time spent":"911.183914ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:31.99765Z","caller":"traceutil/trace.go:171","msg":"trace[1325225608] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24855; }","duration":"1.190888292s","start":"2026-04-27T02:17:30.806744Z","end":"2026-04-27T02:17:31.997632Z","steps":["trace[1325225608] 'agreement among raft nodes before linearized reading' (duration: 1.190615007s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:31.997708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:30.806687Z","time spent":"1.191009565s","remote":"127.0.0.1:46170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-27T02:17:32.012575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.814653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-04-27T02:17:32.0126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.643987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-27T02:17:32.012593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.001684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.012646Z","caller":"traceutil/trace.go:171","msg":"trace[8298513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24856; }","duration":"524.929476ms","start":"2026-04-27T02:17:31.4877Z","end":"2026-04-27T02:17:32.01263Z","steps":["trace[8298513] 'agreement among raft nodes before linearized reading' (duration: 524.755613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.012672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.797823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.012667Z","caller":"traceutil/trace.go:171","msg":"trace[661442356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24856; }","duration":"292.756849ms","start":"2026-04-27T02:17:31.719893Z","end":"2026-04-27T02:17:32.01265Z","steps":["trace[661442356] 'agreement among raft nodes before linearized reading' (duration: 292.581846ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:32.012699Z","caller":"traceutil/trace.go:171","msg":"trace[1981179974] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:24856; }","duration":"599.848004ms","start":"2026-04-27T02:17:31.41284Z","end":"2026-04-27T02:17:32.012688Z","steps":["trace[1981179974] 'agreement among raft nodes before linearized reading' (duration: 599.813463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.012696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.48768Z","time spent":"525.007807ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T02:17:32.012703Z","caller":"traceutil/trace.go:171","msg":"trace[484879063] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:24856; }","duration":"338.127447ms","start":"2026-04-27T02:17:31.674548Z","end":"2026-04-27T02:17:32.012675Z","steps":["trace[484879063] 'agreement among raft nodes before linearized reading' (duration: 337.951633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.012724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.412824Z","time spent":"599.894815ms","remote":"127.0.0.1:37660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:32.012769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.674489Z","time spent":"338.263229ms","remote":"127.0.0.1:53986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:32.012643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.138805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:32.012635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.348895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.012836Z","caller":"traceutil/trace.go:171","msg":"trace[1827733045] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:24856; }","duration":"201.36253ms","start":"2026-04-27T02:17:31.811454Z","end":"2026-04-27T02:17:32.012816Z","steps":["trace[1827733045] 'agreement among raft nodes before linearized reading' (duration: 201.170356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.012877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.285739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.012899Z","caller":"traceutil/trace.go:171","msg":"trace[508932828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24856; }","duration":"610.63165ms","start":"2026-04-27T02:17:31.402246Z","end":"2026-04-27T02:17:32.012877Z","steps":["trace[508932828] 'agreement among raft nodes before linearized reading' (duration: 610.353794ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:32.012929Z","caller":"traceutil/trace.go:171","msg":"trace[1573415453] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:24856; }","duration":"270.649266ms","start":"2026-04-27T02:17:31.742263Z","end":"2026-04-27T02:17:32.012912Z","steps":["trace[1573415453] 'agreement among raft nodes before linearized reading' (duration: 270.159787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.012751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.870608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-27T02:17:32.012968Z","caller":"traceutil/trace.go:171","msg":"trace[1450810221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24856; }","duration":"838.123432ms","start":"2026-04-27T02:17:31.174836Z","end":"2026-04-27T02:17:32.012959Z","steps":["trace[1450810221] 'agreement among raft nodes before linearized reading' (duration: 837.787636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.012973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.402233Z","time spent":"610.716411ms","remote":"127.0.0.1:45954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T02:17:32.013018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.174822Z","time spent":"838.171394ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T02:17:32.012578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.049293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:32.012925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.288138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-mdzcd.18aa1488014529c0\" ","response":"range_response_count:1 size:957"} {"level":"info","ts":"2026-04-27T02:17:32.013152Z","caller":"traceutil/trace.go:171","msg":"trace[1008375112] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:24856; }","duration":"873.620314ms","start":"2026-04-27T02:17:31.139506Z","end":"2026-04-27T02:17:32.013126Z","steps":["trace[1008375112] 'agreement among raft nodes before linearized reading' (duration: 873.020172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.013229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.528496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-27T02:17:32.013256Z","caller":"traceutil/trace.go:171","msg":"trace[1689581650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24856; }","duration":"460.575956ms","start":"2026-04-27T02:17:31.552673Z","end":"2026-04-27T02:17:32.013249Z","steps":["trace[1689581650] 'agreement among raft nodes before linearized reading' (duration: 459.728439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.013241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.139445Z","time spent":"873.761386ms","remote":"127.0.0.1:44468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:32.013275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.552663Z","time spent":"460.608798ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T02:17:32.013236Z","caller":"traceutil/trace.go:171","msg":"trace[744773492] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-mdzcd.18aa1488014529c0; range_end:; response_count:1; response_revision:24856; }","duration":"928.611454ms","start":"2026-04-27T02:17:31.084575Z","end":"2026-04-27T02:17:32.013186Z","steps":["trace[744773492] 'agreement among raft nodes before linearized reading' (duration: 928.195186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.013378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:31.08456Z","time spent":"928.805678ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":980,"request content":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-mdzcd.18aa1488014529c0\" "} {"level":"warn","ts":"2026-04-27T02:17:32.580019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.581263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:17:32.580132Z","caller":"traceutil/trace.go:171","msg":"trace[2129646445] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"564.566268ms","start":"2026-04-27T02:17:32.015546Z","end":"2026-04-27T02:17:32.580113Z","steps":["trace[2129646445] 'process raft request' (duration: 401.794461ms)","trace[2129646445] 'compare' (duration: 162.124374ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:32.580194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.01553Z","time spent":"564.634899ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":939,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:32.8676Z","caller":"traceutil/trace.go:171","msg":"trace[395022857] linearizableReadLoop","detail":"{readStateIndex:25668; appliedIndex:25663; }","duration":"836.988261ms","start":"2026-04-27T02:17:32.030594Z","end":"2026-04-27T02:17:32.867583Z","steps":["trace[395022857] 'read index received' (duration: 386.75934ms)","trace[395022857] 'applied index is now lower than readState.Index' (duration: 450.228101ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:32.867713Z","caller":"traceutil/trace.go:171","msg":"trace[494394485] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"849.954419ms","start":"2026-04-27T02:17:32.017749Z","end":"2026-04-27T02:17:32.867704Z","steps":["trace[494394485] 'process raft request' (duration: 849.695734ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:32.867759Z","caller":"traceutil/trace.go:171","msg":"trace[1975754308] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"848.844158ms","start":"2026-04-27T02:17:32.018888Z","end":"2026-04-27T02:17:32.867732Z","steps":["trace[1975754308] 'process raft request' (duration: 848.657344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.867794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.017723Z","time spent":"850.008551ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:32.867639Z","caller":"traceutil/trace.go:171","msg":"trace[992314621] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"849.860277ms","start":"2026-04-27T02:17:32.017749Z","end":"2026-04-27T02:17:32.867609Z","steps":["trace[992314621] 'process raft request' (duration: 772.235863ms)","trace[992314621] 'compare' (duration: 77.236567ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:32.867881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.018874Z","time spent":"848.941599ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:32.867853Z","caller":"traceutil/trace.go:171","msg":"trace[1229405971] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"849.760776ms","start":"2026-04-27T02:17:32.018037Z","end":"2026-04-27T02:17:32.867797Z","steps":["trace[1229405971] 'process raft request' (duration: 849.47494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.867869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.226505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.867953Z","caller":"traceutil/trace.go:171","msg":"trace[1201106933] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:24861; }","duration":"837.373698ms","start":"2026-04-27T02:17:32.030559Z","end":"2026-04-27T02:17:32.867933Z","steps":["trace[1201106933] 'agreement among raft nodes before linearized reading' (duration: 837.174424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.868005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.03054Z","time spent":"837.45528ms","remote":"127.0.0.1:53758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:32.86805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.018023Z","time spent":"849.917189ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:32.868066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.017728Z","time spent":"850.152163ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:32.877767Z","caller":"traceutil/trace.go:171","msg":"trace[880432989] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"301.178318ms","start":"2026-04-27T02:17:32.576568Z","end":"2026-04-27T02:17:32.877746Z","steps":["trace[880432989] 'process raft request' (duration: 301.030204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.877894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.576542Z","time spent":"301.28407ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:32.878029Z","caller":"traceutil/trace.go:171","msg":"trace[1128403831] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"284.691008ms","start":"2026-04-27T02:17:32.593314Z","end":"2026-04-27T02:17:32.878005Z","steps":["trace[1128403831] 'process raft request' (duration: 284.392432ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:32.878078Z","caller":"traceutil/trace.go:171","msg":"trace[1679693540] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"168.697537ms","start":"2026-04-27T02:17:32.70936Z","end":"2026-04-27T02:17:32.878057Z","steps":["trace[1679693540] 'process raft request' (duration: 168.570134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.878219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.705828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.878251Z","caller":"traceutil/trace.go:171","msg":"trace[82264034] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:24864; }","duration":"277.758668ms","start":"2026-04-27T02:17:32.600483Z","end":"2026-04-27T02:17:32.878241Z","steps":["trace[82264034] 'agreement among raft nodes before linearized reading' (duration: 277.703417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.878233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.94256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-04-27T02:17:32.878262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.800604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-04-27T02:17:32.878244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.440255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:32.878299Z","caller":"traceutil/trace.go:171","msg":"trace[91793624] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:24864; }","duration":"843.040131ms","start":"2026-04-27T02:17:32.035241Z","end":"2026-04-27T02:17:32.878281Z","steps":["trace[91793624] 'agreement among raft nodes before linearized reading' (duration: 842.823767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.878279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.601512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.878315Z","caller":"traceutil/trace.go:171","msg":"trace[1337036852] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24864; }","duration":"608.892706ms","start":"2026-04-27T02:17:32.269407Z","end":"2026-04-27T02:17:32.8783Z","steps":["trace[1337036852] 'agreement among raft nodes before linearized reading' (duration: 608.737683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.878342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.035229Z","time spent":"843.103663ms","remote":"127.0.0.1:46244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":7,"response size":31,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:32.878354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.269389Z","time spent":"608.957837ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-27T02:17:32.878361Z","caller":"traceutil/trace.go:171","msg":"trace[1132032521] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24864; }","duration":"811.722705ms","start":"2026-04-27T02:17:32.066617Z","end":"2026-04-27T02:17:32.878339Z","steps":["trace[1132032521] 'agreement among raft nodes before linearized reading' (duration: 811.567892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.878428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.066599Z","time spent":"811.817397ms","remote":"127.0.0.1:46430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-27T02:17:32.878459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.269938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:32.878502Z","caller":"traceutil/trace.go:171","msg":"trace[1569921016] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:24864; }","duration":"269.37734ms","start":"2026-04-27T02:17:32.609111Z","end":"2026-04-27T02:17:32.878488Z","steps":["trace[1569921016] 'agreement among raft nodes before linearized reading' (duration: 269.061114ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:32.878851Z","caller":"traceutil/trace.go:171","msg":"trace[1125036722] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:24864; }","duration":"443.577728ms","start":"2026-04-27T02:17:32.434744Z","end":"2026-04-27T02:17:32.878322Z","steps":["trace[1125036722] 'agreement among raft nodes before linearized reading' (duration: 443.373674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.878963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:32.43471Z","time spent":"444.232531ms","remote":"127.0.0.1:46388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:32.996413Z","caller":"traceutil/trace.go:171","msg":"trace[1241404516] linearizableReadLoop","detail":"{readStateIndex:25672; appliedIndex:25671; }","duration":"111.904369ms","start":"2026-04-27T02:17:32.884483Z","end":"2026-04-27T02:17:32.996388Z","steps":["trace[1241404516] 'read index received' (duration: 111.515112ms)","trace[1241404516] 'applied index is now lower than readState.Index' (duration: 387.727µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:32.996512Z","caller":"traceutil/trace.go:171","msg":"trace[338262664] transaction","detail":"{read_only:false; response_revision:24865; number_of_response:1; }","duration":"113.546912ms","start":"2026-04-27T02:17:32.882931Z","end":"2026-04-27T02:17:32.996478Z","steps":["trace[338262664] 'process raft request' (duration: 113.042722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:32.996662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.167324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-27T02:17:32.996709Z","caller":"traceutil/trace.go:171","msg":"trace[1152212837] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24865; }","duration":"112.266586ms","start":"2026-04-27T02:17:32.884429Z","end":"2026-04-27T02:17:32.996696Z","steps":["trace[1152212837] 'agreement among raft nodes before linearized reading' (duration: 112.047362ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:39.484285Z","caller":"traceutil/trace.go:171","msg":"trace[584758926] transaction","detail":"{read_only:false; response_revision:24911; number_of_response:1; }","duration":"454.165428ms","start":"2026-04-27T02:17:39.0301Z","end":"2026-04-27T02:17:39.484266Z","steps":["trace[584758926] 'process raft request' (duration: 453.975475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:39.484366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.379403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:39.484389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:39.030082Z","time spent":"454.245661ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:39.484263Z","caller":"traceutil/trace.go:171","msg":"trace[367766653] linearizableReadLoop","detail":"{readStateIndex:25720; appliedIndex:25719; }","duration":"447.265171ms","start":"2026-04-27T02:17:39.036974Z","end":"2026-04-27T02:17:39.484239Z","steps":["trace[367766653] 'read index received' (duration: 447.081397ms)","trace[367766653] 'applied index is now lower than readState.Index' (duration: 181.724µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:39.48442Z","caller":"traceutil/trace.go:171","msg":"trace[883239388] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24911; }","duration":"447.445314ms","start":"2026-04-27T02:17:39.036958Z","end":"2026-04-27T02:17:39.484403Z","steps":["trace[883239388] 'agreement among raft nodes before linearized reading' (duration: 447.354842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:39.484474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:39.036898Z","time spent":"447.563007ms","remote":"127.0.0.1:44262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":29,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:40.197746Z","caller":"traceutil/trace.go:171","msg":"trace[1850752770] transaction","detail":"{read_only:false; response_revision:24912; number_of_response:1; }","duration":"693.661593ms","start":"2026-04-27T02:17:39.504052Z","end":"2026-04-27T02:17:40.197714Z","steps":["trace[1850752770] 'process raft request' (duration: 628.661491ms)","trace[1850752770] 'compare' (duration: 64.328568ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:40.197911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:39.504029Z","time spent":"693.793035ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:41.603892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.241384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"warn","ts":"2026-04-27T02:17:41.603746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.271431ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:41.605019Z","caller":"traceutil/trace.go:171","msg":"trace[113023073] transaction","detail":"{read_only:false; response_revision:24919; number_of_response:1; }","duration":"1.533140792s","start":"2026-04-27T02:17:40.071864Z","end":"2026-04-27T02:17:41.605004Z","steps":["trace[113023073] 'process raft request' (duration: 1.532781335s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.605148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.727960961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:41.605168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.071847Z","time spent":"1.533277144s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:41.605198Z","caller":"traceutil/trace.go:171","msg":"trace[254517486] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24912; }","duration":"431.470955ms","start":"2026-04-27T02:17:41.173633Z","end":"2026-04-27T02:17:41.605104Z","steps":["trace[254517486] 'range keys from in-memory index tree' (duration: 429.24855ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:41.604266Z","caller":"traceutil/trace.go:171","msg":"trace[2107874158] transaction","detail":"{read_only:false; response_revision:24913; number_of_response:1; }","duration":"1.962838102s","start":"2026-04-27T02:17:39.641405Z","end":"2026-04-27T02:17:41.604243Z","steps":["trace[2107874158] 'process raft request' (duration: 1.173164848s)","trace[2107874158] 'compare' (duration: 788.700094ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:41.605312Z","caller":"traceutil/trace.go:171","msg":"trace[2026768520] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:24920; }","duration":"1.728043792s","start":"2026-04-27T02:17:39.877131Z","end":"2026-04-27T02:17:41.605175Z","steps":["trace[2026768520] 'agreement among raft nodes before linearized reading' (duration: 1.727967541s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.605341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:39.641379Z","time spent":"1.963881172s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:41.605409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:39.87711Z","time spent":"1.728283828s","remote":"127.0.0.1:54184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:41.604327Z","caller":"traceutil/trace.go:171","msg":"trace[692744418] transaction","detail":"{read_only:false; response_revision:24914; number_of_response:1; }","duration":"1.956334412s","start":"2026-04-27T02:17:39.647964Z","end":"2026-04-27T02:17:41.604299Z","steps":["trace[692744418] 'process raft request' (duration: 1.956020186s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.605543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:39.647921Z","time spent":"1.957557566s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:41.604388Z","caller":"traceutil/trace.go:171","msg":"trace[150880902] transaction","detail":"{read_only:false; response_revision:24915; number_of_response:1; }","duration":"1.569824527s","start":"2026-04-27T02:17:40.034557Z","end":"2026-04-27T02:17:41.604382Z","steps":["trace[150880902] 'process raft request' (duration: 1.569511631s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.605674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.034531Z","time spent":"1.571115963s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:41.604397Z","caller":"traceutil/trace.go:171","msg":"trace[514314336] transaction","detail":"{read_only:false; response_revision:24916; number_of_response:1; }","duration":"1.567200675s","start":"2026-04-27T02:17:40.037176Z","end":"2026-04-27T02:17:41.604377Z","steps":["trace[514314336] 'process raft request' (duration: 1.566935249s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.605809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.03716Z","time spent":"1.568619262s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:41.604562Z","caller":"traceutil/trace.go:171","msg":"trace[1336132199] transaction","detail":"{read_only:false; response_revision:24917; number_of_response:1; }","duration":"1.553690004s","start":"2026-04-27T02:17:40.050858Z","end":"2026-04-27T02:17:41.604548Z","steps":["trace[1336132199] 'process raft request' (duration: 1.55347589s)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:41.604688Z","caller":"traceutil/trace.go:171","msg":"trace[146038787] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"1.534627833s","start":"2026-04-27T02:17:40.070051Z","end":"2026-04-27T02:17:41.604679Z","steps":["trace[146038787] 'process raft request' (duration: 1.534419258s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.605934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.050821Z","time spent":"1.55504866s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:41.60602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.070031Z","time spent":"1.535932098s","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:41.604987Z","caller":"traceutil/trace.go:171","msg":"trace[419387575] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"688.778934ms","start":"2026-04-27T02:17:40.916186Z","end":"2026-04-27T02:17:41.604965Z","steps":["trace[419387575] 'process raft request' (duration: 688.594921ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:41.605028Z","caller":"traceutil/trace.go:171","msg":"trace[371040090] linearizableReadLoop","detail":"{readStateIndex:25723; appliedIndex:25720; }","duration":"1.727835869s","start":"2026-04-27T02:17:39.877174Z","end":"2026-04-27T02:17:41.60501Z","steps":["trace[371040090] 'read index received' (duration: 255.597025ms)","trace[371040090] 'applied index is now lower than readState.Index' (duration: 1.472236344s)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:17:41.606213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.916162Z","time spent":"689.958768ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:17:41.688613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51954868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:17:41.688705Z","caller":"traceutil/trace.go:171","msg":"trace[858633375] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:24921; }","duration":"1.519694833s","start":"2026-04-27T02:17:40.168986Z","end":"2026-04-27T02:17:41.688681Z","steps":["trace[858633375] 'agreement among raft nodes before linearized reading' (duration: 1.51951481s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.688725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052102355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:41.688769Z","caller":"traceutil/trace.go:171","msg":"trace[417983298] transaction","detail":"{read_only:false; response_revision:24921; number_of_response:1; }","duration":"768.641313ms","start":"2026-04-27T02:17:40.920092Z","end":"2026-04-27T02:17:41.688733Z","steps":["trace[417983298] 'process raft request' (duration: 768.238256ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:41.688808Z","caller":"traceutil/trace.go:171","msg":"trace[424614806] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:24921; }","duration":"1.052230209s","start":"2026-04-27T02:17:40.636559Z","end":"2026-04-27T02:17:41.688789Z","steps":["trace[424614806] 'agreement among raft nodes before linearized reading' (duration: 1.052063475s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.688833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.119922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-04-27T02:17:41.688824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.392172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:41.688861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272411284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:41.68886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.183113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T02:17:41.688872Z","caller":"traceutil/trace.go:171","msg":"trace[1570217631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24921; }","duration":"767.174983ms","start":"2026-04-27T02:17:40.921684Z","end":"2026-04-27T02:17:41.688859Z","steps":["trace[1570217631] 'agreement among raft nodes before linearized reading' (duration: 767.093401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.688882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.920077Z","time spent":"768.739825ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:17:41.688895Z","caller":"traceutil/trace.go:171","msg":"trace[147055676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24921; }","duration":"287.499343ms","start":"2026-04-27T02:17:41.401378Z","end":"2026-04-27T02:17:41.688878Z","steps":["trace[147055676] 'agreement among raft nodes before linearized reading' (duration: 287.300549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.688928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.921671Z","time spent":"767.244525ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T02:17:41.688931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.307849213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:41.688949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.337591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:41.688967Z","caller":"traceutil/trace.go:171","msg":"trace[558498899] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24921; }","duration":"1.307942505s","start":"2026-04-27T02:17:40.381017Z","end":"2026-04-27T02:17:41.688959Z","steps":["trace[558498899] 'agreement among raft nodes before linearized reading' (duration: 1.307895614s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.688754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.168966Z","time spent":"1.519777225s","remote":"127.0.0.1:46252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":31,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:41.688918Z","caller":"traceutil/trace.go:171","msg":"trace[1123530630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24921; }","duration":"771.255955ms","start":"2026-04-27T02:17:40.91765Z","end":"2026-04-27T02:17:41.688906Z","steps":["trace[1123530630] 'agreement among raft nodes before linearized reading' (duration: 771.083621ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:41.689002Z","caller":"traceutil/trace.go:171","msg":"trace[1525163480] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24921; }","duration":"383.431373ms","start":"2026-04-27T02:17:41.305551Z","end":"2026-04-27T02:17:41.688983Z","steps":["trace[1525163480] 'agreement among raft nodes before linearized reading' (duration: 383.359352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.68873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.634333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-04-27T02:17:41.689075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:41.30553Z","time spent":"383.509755ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:41.689106Z","caller":"traceutil/trace.go:171","msg":"trace[1637168397] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24921; }","duration":"769.035061ms","start":"2026-04-27T02:17:40.920061Z","end":"2026-04-27T02:17:41.689096Z","steps":["trace[1637168397] 'agreement among raft nodes before linearized reading' (duration: 768.526371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.689137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.920054Z","time spent":"769.074671ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T02:17:41.689153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.42149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-27T02:17:41.688891Z","caller":"traceutil/trace.go:171","msg":"trace[1339001990] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24921; }","duration":"1.272471344s","start":"2026-04-27T02:17:40.416411Z","end":"2026-04-27T02:17:41.688882Z","steps":["trace[1339001990] 'agreement among raft nodes before linearized reading' (duration: 1.272422903s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.689236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.416392Z","time spent":"1.272822492s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:41.689245Z","caller":"traceutil/trace.go:171","msg":"trace[1310476523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24921; }","duration":"201.549293ms","start":"2026-04-27T02:17:41.487678Z","end":"2026-04-27T02:17:41.689228Z","steps":["trace[1310476523] 'agreement among raft nodes before linearized reading' (duration: 201.247147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.688814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23121444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:41.689563Z","caller":"traceutil/trace.go:171","msg":"trace[334679096] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24921; }","duration":"1.231951755s","start":"2026-04-27T02:17:40.457584Z","end":"2026-04-27T02:17:41.689536Z","steps":["trace[334679096] 'agreement among raft nodes before linearized reading' (duration: 1.23119593s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.68958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.636545Z","time spent":"1.052349871s","remote":"127.0.0.1:50354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:41.689134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.917644Z","time spent":"771.475789ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T02:17:41.689197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.50261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-27T02:17:41.689834Z","caller":"traceutil/trace.go:171","msg":"trace[1569767639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24921; }","duration":"778.170144ms","start":"2026-04-27T02:17:40.911647Z","end":"2026-04-27T02:17:41.689817Z","steps":["trace[1569767639] 'agreement among raft nodes before linearized reading' (duration: 777.256626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.689888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.911632Z","time spent":"778.241535ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T02:17:41.688996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.380998Z","time spent":"1.307990795s","remote":"127.0.0.1:53656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:17:41.688857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.808744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:17:41.689625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:40.45758Z","time spent":"1.232028047s","remote":"127.0.0.1:54000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-04-27T02:17:41.690106Z","caller":"traceutil/trace.go:171","msg":"trace[1504185546] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24921; }","duration":"617.097059ms","start":"2026-04-27T02:17:41.072985Z","end":"2026-04-27T02:17:41.690082Z","steps":["trace[1504185546] 'agreement among raft nodes before linearized reading' (duration: 615.769873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:41.690222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:17:41.072968Z","time spent":"617.229982ms","remote":"127.0.0.1:44316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:17:44.16351Z","caller":"traceutil/trace.go:171","msg":"trace[1790792754] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"121.894549ms","start":"2026-04-27T02:17:44.041584Z","end":"2026-04-27T02:17:44.163478Z","steps":["trace[1790792754] 'process raft request' (duration: 121.665095ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:46.261737Z","caller":"traceutil/trace.go:171","msg":"trace[447680145] transaction","detail":"{read_only:false; response_revision:25015; number_of_response:1; }","duration":"184.355629ms","start":"2026-04-27T02:17:46.077325Z","end":"2026-04-27T02:17:46.261681Z","steps":["trace[447680145] 'process raft request' (duration: 184.093074ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:17:50.594206Z","caller":"traceutil/trace.go:171","msg":"trace[1337710863] linearizableReadLoop","detail":"{readStateIndex:25880; appliedIndex:25879; }","duration":"199.012163ms","start":"2026-04-27T02:17:50.395146Z","end":"2026-04-27T02:17:50.594158Z","steps":["trace[1337710863] 'read index received' (duration: 198.827659ms)","trace[1337710863] 'applied index is now lower than readState.Index' (duration: 183.394µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:17:50.594293Z","caller":"traceutil/trace.go:171","msg":"trace[1242886047] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"240.666556ms","start":"2026-04-27T02:17:50.353595Z","end":"2026-04-27T02:17:50.594261Z","steps":["trace[1242886047] 'process raft request' (duration: 240.34964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:50.594401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.325218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:50.594448Z","caller":"traceutil/trace.go:171","msg":"trace[1735337989] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:25068; }","duration":"126.45904ms","start":"2026-04-27T02:17:50.467977Z","end":"2026-04-27T02:17:50.594436Z","steps":["trace[1735337989] 'agreement among raft nodes before linearized reading' (duration: 126.354278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:17:50.594431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.241387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:17:50.594573Z","caller":"traceutil/trace.go:171","msg":"trace[1645617471] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:25068; }","duration":"199.39987ms","start":"2026-04-27T02:17:50.39513Z","end":"2026-04-27T02:17:50.59453Z","steps":["trace[1645617471] 'agreement among raft nodes before linearized reading' (duration: 199.147495ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:05.85656Z","caller":"traceutil/trace.go:171","msg":"trace[504208136] transaction","detail":"{read_only:false; response_revision:25182; number_of_response:1; }","duration":"138.097664ms","start":"2026-04-27T02:18:05.718431Z","end":"2026-04-27T02:18:05.856528Z","steps":["trace[504208136] 'process raft request' (duration: 134.154325ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:05.905761Z","caller":"traceutil/trace.go:171","msg":"trace[2089642435] transaction","detail":"{read_only:false; response_revision:25184; number_of_response:1; }","duration":"158.566783ms","start":"2026-04-27T02:18:05.747165Z","end":"2026-04-27T02:18:05.905732Z","steps":["trace[2089642435] 'process raft request' (duration: 158.477591ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:05.905877Z","caller":"traceutil/trace.go:171","msg":"trace[278376925] transaction","detail":"{read_only:false; response_revision:25183; number_of_response:1; }","duration":"159.498062ms","start":"2026-04-27T02:18:05.746348Z","end":"2026-04-27T02:18:05.905846Z","steps":["trace[278376925] 'process raft request' (duration: 159.154115ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:05.906165Z","caller":"traceutil/trace.go:171","msg":"trace[1400817083] transaction","detail":"{read_only:false; response_revision:25185; number_of_response:1; }","duration":"156.759087ms","start":"2026-04-27T02:18:05.749387Z","end":"2026-04-27T02:18:05.906146Z","steps":["trace[1400817083] 'process raft request' (duration: 156.300117ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:05.906333Z","caller":"traceutil/trace.go:171","msg":"trace[2031627185] transaction","detail":"{read_only:false; response_revision:25186; number_of_response:1; }","duration":"156.187047ms","start":"2026-04-27T02:18:05.750135Z","end":"2026-04-27T02:18:05.906322Z","steps":["trace[2031627185] 'process raft request' (duration: 155.952132ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:05.907309Z","caller":"traceutil/trace.go:171","msg":"trace[1971430130] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"141.251267ms","start":"2026-04-27T02:18:05.766033Z","end":"2026-04-27T02:18:05.907284Z","steps":["trace[1971430130] 'process raft request' (duration: 140.246407ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:06.101288Z","caller":"traceutil/trace.go:171","msg":"trace[2013191120] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"189.645405ms","start":"2026-04-27T02:18:05.911588Z","end":"2026-04-27T02:18:06.101233Z","steps":["trace[2013191120] 'process raft request' (duration: 102.992741ms)","trace[2013191120] 'compare' (duration: 86.428589ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:06.500745Z","caller":"traceutil/trace.go:171","msg":"trace[1549231651] linearizableReadLoop","detail":"{readStateIndex:26007; appliedIndex:26003; }","duration":"245.536094ms","start":"2026-04-27T02:18:06.255189Z","end":"2026-04-27T02:18:06.500725Z","steps":["trace[1549231651] 'read index received' (duration: 195.724677ms)","trace[1549231651] 'applied index is now lower than readState.Index' (duration: 49.810747ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:06.500757Z","caller":"traceutil/trace.go:171","msg":"trace[1576615307] transaction","detail":"{read_only:false; response_revision:25192; number_of_response:1; }","duration":"587.809563ms","start":"2026-04-27T02:18:05.912928Z","end":"2026-04-27T02:18:06.500738Z","steps":["trace[1576615307] 'process raft request' (duration: 587.769322ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:06.500772Z","caller":"traceutil/trace.go:171","msg":"trace[161499284] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"588.913105ms","start":"2026-04-27T02:18:05.911817Z","end":"2026-04-27T02:18:06.50073Z","steps":["trace[161499284] 'process raft request' (duration: 588.802703ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:06.500824Z","caller":"traceutil/trace.go:171","msg":"trace[220534519] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"588.985146ms","start":"2026-04-27T02:18:05.911806Z","end":"2026-04-27T02:18:06.500791Z","steps":["trace[220534519] 'process raft request' (duration: 539.161609ms)","trace[220534519] 'compare' (duration: 49.47599ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:06.500755Z","caller":"traceutil/trace.go:171","msg":"trace[1787044746] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"588.326654ms","start":"2026-04-27T02:18:05.912406Z","end":"2026-04-27T02:18:06.500733Z","steps":["trace[1787044746] 'process raft request' (duration: 588.263693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:06.500889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:05.912922Z","time spent":"587.896586ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:06.500931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:05.911786Z","time spent":"589.060828ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:06.500946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:05.911796Z","time spent":"589.081799ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:06.500959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:05.912399Z","time spent":"588.504867ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:06.500942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.717297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:18:06.501104Z","caller":"traceutil/trace.go:171","msg":"trace[1081439140] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25192; }","duration":"245.890261ms","start":"2026-04-27T02:18:06.25514Z","end":"2026-04-27T02:18:06.50103Z","steps":["trace[1081439140] 'agreement among raft nodes before linearized reading' (duration: 245.653876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:06.546743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.796528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:18:06.546791Z","caller":"traceutil/trace.go:171","msg":"trace[504598220] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:25193; }","duration":"262.885971ms","start":"2026-04-27T02:18:06.283893Z","end":"2026-04-27T02:18:06.546779Z","steps":["trace[504598220] 'agreement among raft nodes before linearized reading' (duration: 262.79676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:06.546846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.375879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:18:06.546907Z","caller":"traceutil/trace.go:171","msg":"trace[315454954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25193; }","duration":"145.510573ms","start":"2026-04-27T02:18:06.401382Z","end":"2026-04-27T02:18:06.546893Z","steps":["trace[315454954] 'agreement among raft nodes before linearized reading' (duration: 145.352979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.243269Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566652363416190,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T02:18:08.243603Z","caller":"traceutil/trace.go:171","msg":"trace[2020123869] transaction","detail":"{read_only:false; response_revision:25194; number_of_response:1; }","duration":"526.885314ms","start":"2026-04-27T02:18:07.716686Z","end":"2026-04-27T02:18:08.243571Z","steps":["trace[2020123869] 'process raft request' (duration: 526.610219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.243803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.716669Z","time spent":"527.041487ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:18:08.35784Z","caller":"traceutil/trace.go:171","msg":"trace[2577379] transaction","detail":"{read_only:false; response_revision:25195; number_of_response:1; }","duration":"640.145421ms","start":"2026-04-27T02:18:07.717671Z","end":"2026-04-27T02:18:08.357816Z","steps":["trace[2577379] 'process raft request' (duration: 639.919047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.357992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.717662Z","time spent":"640.250624ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:18:08.358237Z","caller":"traceutil/trace.go:171","msg":"trace[917888230] transaction","detail":"{read_only:false; response_revision:25196; number_of_response:1; }","duration":"496.934075ms","start":"2026-04-27T02:18:07.861275Z","end":"2026-04-27T02:18:08.358209Z","steps":["trace[917888230] 'process raft request' (duration: 496.498706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.358431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.861253Z","time spent":"497.079017ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:18:08.35854Z","caller":"traceutil/trace.go:171","msg":"trace[1120220590] transaction","detail":"{read_only:false; response_revision:25197; number_of_response:1; }","duration":"447.280471ms","start":"2026-04-27T02:18:07.911248Z","end":"2026-04-27T02:18:08.358528Z","steps":["trace[1120220590] 'process raft request' (duration: 446.840212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.358611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.911229Z","time spent":"447.344163ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:18:08.358905Z","caller":"traceutil/trace.go:171","msg":"trace[452281520] transaction","detail":"{read_only:false; response_revision:25198; number_of_response:1; }","duration":"445.978335ms","start":"2026-04-27T02:18:07.912917Z","end":"2026-04-27T02:18:08.358895Z","steps":["trace[452281520] 'process raft request' (duration: 445.564627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.358965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.912894Z","time spent":"446.037906ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:18:08.35921Z","caller":"traceutil/trace.go:171","msg":"trace[1324266311] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"446.23328ms","start":"2026-04-27T02:18:07.912958Z","end":"2026-04-27T02:18:08.359191Z","steps":["trace[1324266311] 'process raft request' (duration: 445.894813ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:08.359249Z","caller":"traceutil/trace.go:171","msg":"trace[1515751669] transaction","detail":"{read_only:false; response_revision:25201; number_of_response:1; }","duration":"445.515936ms","start":"2026-04-27T02:18:07.913714Z","end":"2026-04-27T02:18:08.35923Z","steps":["trace[1515751669] 'process raft request' (duration: 445.453365ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:08.359283Z","caller":"traceutil/trace.go:171","msg":"trace[828898950] transaction","detail":"{read_only:false; response_revision:25200; number_of_response:1; }","duration":"445.657818ms","start":"2026-04-27T02:18:07.913599Z","end":"2026-04-27T02:18:08.359257Z","steps":["trace[828898950] 'process raft request' (duration: 445.475945ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:08.359302Z","caller":"traceutil/trace.go:171","msg":"trace[914972941] linearizableReadLoop","detail":"{readStateIndex:26010; appliedIndex:26008; }","duration":"616.61073ms","start":"2026-04-27T02:18:07.742667Z","end":"2026-04-27T02:18:08.359278Z","steps":["trace[914972941] 'read index received' (duration: 500.68035ms)","trace[914972941] 'applied index is now lower than readState.Index' (duration: 115.92961ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:08.359355Z","caller":"traceutil/trace.go:171","msg":"trace[370652294] transaction","detail":"{read_only:false; response_revision:25202; number_of_response:1; }","duration":"410.612026ms","start":"2026-04-27T02:18:07.948734Z","end":"2026-04-27T02:18:08.359346Z","steps":["trace[370652294] 'process raft request' (duration: 410.461673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.359356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.913689Z","time spent":"445.608677ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:08.359298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.912945Z","time spent":"446.304841ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:08.359354Z","caller":"etcdserver/v3_server.go:874","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":296566652363416200,"received-request-id":296566652363416190} {"level":"warn","ts":"2026-04-27T02:18:08.359403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.948706Z","time spent":"410.668318ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:08.359402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.913592Z","time spent":"445.74299ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:18:08.359416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.741272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:18:08.359462Z","caller":"traceutil/trace.go:171","msg":"trace[1938901481] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25202; }","duration":"616.817733ms","start":"2026-04-27T02:18:07.742632Z","end":"2026-04-27T02:18:08.359449Z","steps":["trace[1938901481] 'agreement among raft nodes before linearized reading' (duration: 616.724511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:08.359493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:07.742617Z","time spent":"616.868295ms","remote":"127.0.0.1:44510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T02:18:08.359515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.152576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:137"} {"level":"warn","ts":"2026-04-27T02:18:08.359524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.85029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-27T02:18:08.359535Z","caller":"traceutil/trace.go:171","msg":"trace[1021054241] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:25202; }","duration":"252.209908ms","start":"2026-04-27T02:18:08.10732Z","end":"2026-04-27T02:18:08.35953Z","steps":["trace[1021054241] 'agreement among raft nodes before linearized reading' (duration: 252.130726ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:08.359553Z","caller":"traceutil/trace.go:171","msg":"trace[1367802894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25202; }","duration":"254.926412ms","start":"2026-04-27T02:18:08.104619Z","end":"2026-04-27T02:18:08.359545Z","steps":["trace[1367802894] 'agreement among raft nodes before linearized reading' (duration: 254.82816ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:09.429791Z","caller":"traceutil/trace.go:171","msg":"trace[643709002] transaction","detail":"{read_only:false; response_revision:25218; number_of_response:1; }","duration":"129.44278ms","start":"2026-04-27T02:18:09.300323Z","end":"2026-04-27T02:18:09.429766Z","steps":["trace[643709002] 'process raft request' (duration: 129.231086ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:09.660009Z","caller":"traceutil/trace.go:171","msg":"trace[1963781589] transaction","detail":"{read_only:false; response_revision:25219; number_of_response:1; }","duration":"223.3174ms","start":"2026-04-27T02:18:09.436667Z","end":"2026-04-27T02:18:09.659984Z","steps":["trace[1963781589] 'process raft request' (duration: 223.165387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:13.463614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.407589ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-04-27T02:18:13.530032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.842618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:18:13.530127Z","caller":"traceutil/trace.go:171","msg":"trace[1490664455] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25251; }","duration":"127.985881ms","start":"2026-04-27T02:18:13.402114Z","end":"2026-04-27T02:18:13.5301Z","steps":["trace[1490664455] 'agreement among raft nodes before linearized reading' (duration: 62.029602ms)","trace[1490664455] 'range keys from in-memory index tree' (duration: 65.810867ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:18:20.633816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.124435ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-27T02:18:20.633953Z","caller":"traceutil/trace.go:171","msg":"trace[1391622444] transaction","detail":"{read_only:false; response_revision:25305; number_of_response:1; }","duration":"207.521413ms","start":"2026-04-27T02:18:20.426408Z","end":"2026-04-27T02:18:20.633929Z","steps":["trace[1391622444] 'compare' (duration: 200.933912ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:20.905373Z","caller":"traceutil/trace.go:171","msg":"trace[1868112611] transaction","detail":"{read_only:false; response_revision:25309; number_of_response:1; }","duration":"265.34751ms","start":"2026-04-27T02:18:20.640005Z","end":"2026-04-27T02:18:20.905353Z","steps":["trace[1868112611] 'process raft request' (duration: 265.276909ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:20.905442Z","caller":"traceutil/trace.go:171","msg":"trace[920206151] transaction","detail":"{read_only:false; response_revision:25308; number_of_response:1; }","duration":"266.341909ms","start":"2026-04-27T02:18:20.639076Z","end":"2026-04-27T02:18:20.905418Z","steps":["trace[920206151] 'process raft request' (duration: 226.235878ms)","trace[920206151] 'compare' (duration: 39.625882ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:26.603698Z","caller":"traceutil/trace.go:171","msg":"trace[185038069] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"176.649475ms","start":"2026-04-27T02:18:26.427012Z","end":"2026-04-27T02:18:26.603661Z","steps":["trace[185038069] 'process raft request' (duration: 141.779477ms)","trace[185038069] 'compare' (duration: 34.713025ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:26.654793Z","caller":"traceutil/trace.go:171","msg":"trace[412540648] transaction","detail":"{read_only:false; response_revision:25343; number_of_response:1; }","duration":"223.202017ms","start":"2026-04-27T02:18:26.431572Z","end":"2026-04-27T02:18:26.654774Z","steps":["trace[412540648] 'process raft request' (duration: 223.026463ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:26.655012Z","caller":"traceutil/trace.go:171","msg":"trace[2075861207] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"221.779828ms","start":"2026-04-27T02:18:26.433222Z","end":"2026-04-27T02:18:26.655001Z","steps":["trace[2075861207] 'process raft request' (duration: 221.480932ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:26.655334Z","caller":"traceutil/trace.go:171","msg":"trace[267261231] transaction","detail":"{read_only:false; response_revision:25345; number_of_response:1; }","duration":"220.587404ms","start":"2026-04-27T02:18:26.434691Z","end":"2026-04-27T02:18:26.655279Z","steps":["trace[267261231] 'process raft request' (duration: 220.251647ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:26.655598Z","caller":"traceutil/trace.go:171","msg":"trace[2118703973] transaction","detail":"{read_only:false; response_revision:25346; number_of_response:1; }","duration":"219.81954ms","start":"2026-04-27T02:18:26.435767Z","end":"2026-04-27T02:18:26.655587Z","steps":["trace[2118703973] 'process raft request' (duration: 219.426321ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:26.655792Z","caller":"traceutil/trace.go:171","msg":"trace[1882690888] linearizableReadLoop","detail":"{readStateIndex:26167; appliedIndex:26160; }","duration":"197.067124ms","start":"2026-04-27T02:18:26.458702Z","end":"2026-04-27T02:18:26.655769Z","steps":["trace[1882690888] 'read index received' (duration: 110.086693ms)","trace[1882690888] 'applied index is now lower than readState.Index' (duration: 86.979361ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:26.655791Z","caller":"traceutil/trace.go:171","msg":"trace[2041208464] transaction","detail":"{read_only:false; response_revision:25347; number_of_response:1; }","duration":"216.701827ms","start":"2026-04-27T02:18:26.43907Z","end":"2026-04-27T02:18:26.655772Z","steps":["trace[2041208464] 'process raft request' (duration: 216.475983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:26.656019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.290169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-27T02:18:26.656077Z","caller":"traceutil/trace.go:171","msg":"trace[1008558049] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25348; }","duration":"197.392951ms","start":"2026-04-27T02:18:26.458669Z","end":"2026-04-27T02:18:26.656062Z","steps":["trace[1008558049] 'agreement among raft nodes before linearized reading' (duration: 197.224458ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:26.655812Z","caller":"traceutil/trace.go:171","msg":"trace[197054882] transaction","detail":"{read_only:false; response_revision:25348; number_of_response:1; }","duration":"215.975102ms","start":"2026-04-27T02:18:26.439826Z","end":"2026-04-27T02:18:26.655801Z","steps":["trace[197054882] 'process raft request' (duration: 215.86843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:26.657866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.38914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-04-27T02:18:26.657929Z","caller":"traceutil/trace.go:171","msg":"trace[1211935240] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25348; }","duration":"171.489001ms","start":"2026-04-27T02:18:26.486425Z","end":"2026-04-27T02:18:26.657914Z","steps":["trace[1211935240] 'agreement among raft nodes before linearized reading' (duration: 169.492812ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:26.921251Z","caller":"traceutil/trace.go:171","msg":"trace[921531867] linearizableReadLoop","detail":"{readStateIndex:26168; appliedIndex:26167; }","duration":"176.707486ms","start":"2026-04-27T02:18:26.744526Z","end":"2026-04-27T02:18:26.921234Z","steps":["trace[921531867] 'read index received' (duration: 129.029612ms)","trace[921531867] 'applied index is now lower than readState.Index' (duration: 47.677364ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:26.921442Z","caller":"traceutil/trace.go:171","msg":"trace[349371562] transaction","detail":"{read_only:false; response_revision:25349; number_of_response:1; }","duration":"246.656176ms","start":"2026-04-27T02:18:26.674745Z","end":"2026-04-27T02:18:26.921401Z","steps":["trace[349371562] 'process raft request' (duration: 198.84137ms)","trace[349371562] 'compare' (duration: 47.524821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:18:26.921564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.014302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-27T02:18:26.921645Z","caller":"traceutil/trace.go:171","msg":"trace[1269532602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25349; }","duration":"177.137976ms","start":"2026-04-27T02:18:26.744487Z","end":"2026-04-27T02:18:26.921625Z","steps":["trace[1269532602] 'agreement among raft nodes before linearized reading' (duration: 176.89689ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:27.170002Z","caller":"traceutil/trace.go:171","msg":"trace[1064948881] transaction","detail":"{read_only:false; response_revision:25350; number_of_response:1; }","duration":"258.184726ms","start":"2026-04-27T02:18:26.911782Z","end":"2026-04-27T02:18:27.169967Z","steps":["trace[1064948881] 'process raft request' (duration: 159.562993ms)","trace[1064948881] 'compare' (duration: 98.361858ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:27.170066Z","caller":"traceutil/trace.go:171","msg":"trace[438241739] linearizableReadLoop","detail":"{readStateIndex:26169; appliedIndex:26168; }","duration":"248.715208ms","start":"2026-04-27T02:18:26.92133Z","end":"2026-04-27T02:18:27.170045Z","steps":["trace[438241739] 'read index received' (duration: 150.131115ms)","trace[438241739] 'applied index is now lower than readState.Index' (duration: 98.581662ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:18:27.170127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.742588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:18:27.170192Z","caller":"traceutil/trace.go:171","msg":"trace[1002823212] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25350; }","duration":"302.84896ms","start":"2026-04-27T02:18:26.867325Z","end":"2026-04-27T02:18:27.170174Z","steps":["trace[1002823212] 'agreement among raft nodes before linearized reading' (duration: 302.731288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:27.170198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.351043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-27T02:18:27.170227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:26.867311Z","time spent":"302.906362ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-04-27T02:18:27.170235Z","caller":"traceutil/trace.go:171","msg":"trace[1879350311] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:25350; }","duration":"425.437764ms","start":"2026-04-27T02:18:26.744788Z","end":"2026-04-27T02:18:27.170226Z","steps":["trace[1879350311] 'agreement among raft nodes before linearized reading' (duration: 425.357292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:27.170343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:26.744768Z","time spent":"425.563537ms","remote":"127.0.0.1:50962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-04-27T02:18:27.170537Z","caller":"traceutil/trace.go:171","msg":"trace[1963618871] transaction","detail":"{read_only:false; response_revision:25351; number_of_response:1; }","duration":"245.337759ms","start":"2026-04-27T02:18:26.925185Z","end":"2026-04-27T02:18:27.170523Z","steps":["trace[1963618871] 'process raft request' (duration: 245.189646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:27.170558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.814581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-04-27T02:18:27.170609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.683296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T02:18:27.170653Z","caller":"traceutil/trace.go:171","msg":"trace[503173511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25351; }","duration":"242.792378ms","start":"2026-04-27T02:18:26.927849Z","end":"2026-04-27T02:18:27.170641Z","steps":["trace[503173511] 'agreement among raft nodes before linearized reading' (duration: 242.638285ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:27.170654Z","caller":"traceutil/trace.go:171","msg":"trace[190259521] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25350; }","duration":"420.927094ms","start":"2026-04-27T02:18:26.749698Z","end":"2026-04-27T02:18:27.170625Z","steps":["trace[190259521] 'agreement among raft nodes before linearized reading' (duration: 420.362863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:18:27.17071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:18:26.749691Z","time spent":"421.004195ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T02:18:27.170789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.522863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-27T02:18:27.170817Z","caller":"traceutil/trace.go:171","msg":"trace[1364496648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25351; }","duration":"237.588344ms","start":"2026-04-27T02:18:26.933221Z","end":"2026-04-27T02:18:27.170809Z","steps":["trace[1364496648] 'agreement among raft nodes before linearized reading' (duration: 237.508702ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:27.36667Z","caller":"traceutil/trace.go:171","msg":"trace[1416579302] linearizableReadLoop","detail":"{readStateIndex:26173; appliedIndex:26170; }","duration":"191.461631ms","start":"2026-04-27T02:18:27.175185Z","end":"2026-04-27T02:18:27.366646Z","steps":["trace[1416579302] 'read index received' (duration: 62.622302ms)","trace[1416579302] 'applied index is now lower than readState.Index' (duration: 128.838239ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:18:27.366799Z","caller":"traceutil/trace.go:171","msg":"trace[846604882] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"192.105034ms","start":"2026-04-27T02:18:27.174682Z","end":"2026-04-27T02:18:27.366787Z","steps":["trace[846604882] 'process raft request' (duration: 134.467541ms)","trace[846604882] 'compare' (duration: 57.039391ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:18:27.366861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.648835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-27T02:18:27.366874Z","caller":"traceutil/trace.go:171","msg":"trace[1218624905] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"192.078724ms","start":"2026-04-27T02:18:27.174766Z","end":"2026-04-27T02:18:27.366845Z","steps":["trace[1218624905] 'process raft request' (duration: 191.779828ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:27.366928Z","caller":"traceutil/trace.go:171","msg":"trace[1702560596] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25354; }","duration":"191.760307ms","start":"2026-04-27T02:18:27.175148Z","end":"2026-04-27T02:18:27.366908Z","steps":["trace[1702560596] 'agreement among raft nodes before linearized reading' (duration: 191.633065ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.838097Z","caller":"traceutil/trace.go:171","msg":"trace[1562806079] transaction","detail":"{read_only:false; response_revision:25517; number_of_response:1; }","duration":"144.439641ms","start":"2026-04-27T02:18:48.693563Z","end":"2026-04-27T02:18:48.838002Z","steps":["trace[1562806079] 'process raft request' (duration: 144.172386ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.981565Z","caller":"traceutil/trace.go:171","msg":"trace[438270471] transaction","detail":"{read_only:false; response_revision:25518; number_of_response:1; }","duration":"233.503692ms","start":"2026-04-27T02:18:48.748027Z","end":"2026-04-27T02:18:48.98153Z","steps":["trace[438270471] 'process raft request' (duration: 233.360139ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.981869Z","caller":"traceutil/trace.go:171","msg":"trace[323076591] transaction","detail":"{read_only:false; response_revision:25519; number_of_response:1; }","duration":"228.949601ms","start":"2026-04-27T02:18:48.752894Z","end":"2026-04-27T02:18:48.981843Z","steps":["trace[323076591] 'process raft request' (duration: 228.609515ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.982085Z","caller":"traceutil/trace.go:171","msg":"trace[36943205] transaction","detail":"{read_only:false; response_revision:25520; number_of_response:1; }","duration":"226.645085ms","start":"2026-04-27T02:18:48.755429Z","end":"2026-04-27T02:18:48.982074Z","steps":["trace[36943205] 'process raft request' (duration: 226.285278ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.982139Z","caller":"traceutil/trace.go:171","msg":"trace[1664590093] transaction","detail":"{read_only:false; response_revision:25523; number_of_response:1; }","duration":"219.437832ms","start":"2026-04-27T02:18:48.762676Z","end":"2026-04-27T02:18:48.982113Z","steps":["trace[1664590093] 'process raft request' (duration: 219.393341ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.982203Z","caller":"traceutil/trace.go:171","msg":"trace[1560058144] transaction","detail":"{read_only:false; response_revision:25521; number_of_response:1; }","duration":"224.641645ms","start":"2026-04-27T02:18:48.757555Z","end":"2026-04-27T02:18:48.982196Z","steps":["trace[1560058144] 'process raft request' (duration: 224.281798ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:48.98228Z","caller":"traceutil/trace.go:171","msg":"trace[391361593] transaction","detail":"{read_only:false; response_revision:25522; number_of_response:1; }","duration":"223.37176ms","start":"2026-04-27T02:18:48.758903Z","end":"2026-04-27T02:18:48.982275Z","steps":["trace[391361593] 'process raft request' (duration: 223.092954ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:18:49.157263Z","caller":"traceutil/trace.go:171","msg":"trace[1775095954] transaction","detail":"{read_only:false; response_revision:25524; number_of_response:1; }","duration":"117.250997ms","start":"2026-04-27T02:18:49.039981Z","end":"2026-04-27T02:18:49.157232Z","steps":["trace[1775095954] 'process raft request' (duration: 32.898009ms)","trace[1775095954] 'compare' (duration: 83.903209ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:18:49.37364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.41673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-27T02:18:49.373736Z","caller":"traceutil/trace.go:171","msg":"trace[2135620232] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25524; }","duration":"104.590593ms","start":"2026-04-27T02:18:49.269124Z","end":"2026-04-27T02:18:49.373715Z","steps":["trace[2135620232] 'range keys from in-memory index tree' (duration: 104.111403ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:19:22.052517Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006894.wal"} {"level":"info","ts":"2026-04-27T02:19:35.087937Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23088} {"level":"info","ts":"2026-04-27T02:19:35.219136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23088,"took":"127.832619ms","hash":3501491552,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":35885056,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-04-27T02:19:35.219189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3501491552,"revision":23088,"compact-revision":20092} {"level":"info","ts":"2026-04-27T02:24:35.09467Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26033} {"level":"info","ts":"2026-04-27T02:24:35.240081Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26033,"took":"141.58022ms","hash":1670000516,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":34394112,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-27T02:24:35.240157Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1670000516,"revision":26033,"compact-revision":23088} {"level":"info","ts":"2026-04-27T02:25:18.16852Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-27T02:25:18.180198Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-04-27T02:25:18.180303Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-04-27T02:29:35.101372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28734} {"level":"info","ts":"2026-04-27T02:29:35.241128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28734,"took":"134.57136ms","hash":2450983862,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":30650368,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-27T02:29:35.241201Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2450983862,"revision":28734,"compact-revision":26033} {"level":"info","ts":"2026-04-27T02:34:35.109456Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30956} {"level":"info","ts":"2026-04-27T02:34:35.224391Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30956,"took":"112.0387ms","hash":1518566468,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":31051776,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-27T02:34:35.224466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1518566468,"revision":30956,"compact-revision":28734} {"level":"info","ts":"2026-04-27T02:39:35.115795Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33229} {"level":"info","ts":"2026-04-27T02:39:35.250332Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33229,"took":"130.164022ms","hash":3709609443,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":32059392,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-27T02:39:35.250399Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3709609443,"revision":33229,"compact-revision":30956} {"level":"info","ts":"2026-04-27T02:44:35.121658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35521} {"level":"info","ts":"2026-04-27T02:44:35.268893Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35521,"took":"142.495509ms","hash":54555940,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":31821824,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-27T02:44:35.268975Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":54555940,"revision":35521,"compact-revision":33229} {"level":"info","ts":"2026-04-27T02:46:46.004477Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-27T02:46:46.009271Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-04-27T02:46:46.009375Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}