{"level":"warn","ts":"2026-06-06T05:06:42.14529Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-06T05:06:42.145385Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-06-06T05:06:42.145456Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-06T05:06:42.145465Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-06T05:06:42.145485Z","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-06-06T05:06:42.146128Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-06-06T05:06:42.146215Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-06-06T05:06:42.151017Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.593762ms"} {"level":"info","ts":"2026-06-06T05:06:42.16281Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-06-06T05:06:42.162915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-06-06T05:06:42.162938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-06-06T05:06:42.162951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-06T05:06:42.16296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-06-06T05:06:42.162998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-06-06T05:06:42.166936Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-06T05:06:42.169499Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-06T05:06:42.170786Z","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-06-06T05:06:42.175617Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-06T05:06:42.175946Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-06T05:06:42.176272Z","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-06-06T05:06:42.176378Z","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-06-06T05:06:42.176447Z","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-06-06T05:06:42.177123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-06-06T05:06:42.177286Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-06T05:06:42.178189Z","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-06-06T05:06:42.178346Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-06T05:06:42.178384Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-06T05:06:42.178447Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-06T05:06:42.178541Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-06T05:06:42.663626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-06-06T05:06:42.663692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-06T05:06:42.663863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-06-06T05:06:42.6639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-06-06T05:06:42.663917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-06T05:06:42.663943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-06-06T05:06:42.663963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-06T05:06:42.665042Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T05:06:42.665939Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-06T05:06:42.665991Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-06T05:06:42.665973Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-06-06T05:06:42.666333Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-06T05:06:42.666361Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-06T05:06:42.666481Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T05:06:42.666555Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T05:06:42.66658Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T05:06:42.670064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-06-06T05:06:42.676152Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-06T05:07:24.819524Z","caller":"traceutil/trace.go:171","msg":"trace[2121531824] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"220.880403ms","start":"2026-06-06T05:07:24.598619Z","end":"2026-06-06T05:07:24.8195Z","steps":["trace[2121531824] 'process raft request' (duration: 174.848796ms)","trace[2121531824] 'compare' (duration: 45.906084ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:07:24.819507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.184943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-06T05:07:24.819648Z","caller":"traceutil/trace.go:171","msg":"trace[245682506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"224.384278ms","start":"2026-06-06T05:07:24.595239Z","end":"2026-06-06T05:07:24.819623Z","steps":["trace[245682506] 'range keys from in-memory index tree' (duration: 223.979318ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:07:25.179477Z","caller":"traceutil/trace.go:171","msg":"trace[1495860151] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"266.800479ms","start":"2026-06-06T05:07:24.912647Z","end":"2026-06-06T05:07:25.179448Z","steps":["trace[1495860151] 'process raft request' (duration: 266.581203ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:07:25.387278Z","caller":"traceutil/trace.go:171","msg":"trace[1917954895] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"126.965684ms","start":"2026-06-06T05:07:25.260279Z","end":"2026-06-06T05:07:25.387245Z","steps":["trace[1917954895] 'process raft request' (duration: 124.820771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:07:39.805638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.885816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fpfq5\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-06T05:07:39.805741Z","caller":"traceutil/trace.go:171","msg":"trace[1143742769] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fpfq5; range_end:; response_count:1; response_revision:744; }","duration":"238.008839ms","start":"2026-06-06T05:07:39.567709Z","end":"2026-06-06T05:07:39.805718Z","steps":["trace[1143742769] 'range keys from in-memory index tree' (duration: 237.580649ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:08:13.016539Z","caller":"traceutil/trace.go:171","msg":"trace[190284416] linearizableReadLoop","detail":"{readStateIndex:1197; appliedIndex:1196; }","duration":"122.36817ms","start":"2026-06-06T05:08:12.894142Z","end":"2026-06-06T05:08:13.016511Z","steps":["trace[190284416] 'read index received' (duration: 122.196256ms)","trace[190284416] 'applied index is now lower than readState.Index' (duration: 170.634µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:08:13.016671Z","caller":"traceutil/trace.go:171","msg":"trace[1106569655] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"193.176932ms","start":"2026-06-06T05:08:12.823467Z","end":"2026-06-06T05:08:13.016644Z","steps":["trace[1106569655] 'process raft request' (duration: 192.872995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:08:13.016728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.559204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-06T05:08:13.016766Z","caller":"traceutil/trace.go:171","msg":"trace[652335369] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1159; }","duration":"122.647986ms","start":"2026-06-06T05:08:12.894108Z","end":"2026-06-06T05:08:13.016756Z","steps":["trace[652335369] 'agreement among raft nodes before linearized reading' (duration: 122.561934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:09:04.068522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.261019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-06T05:09:04.068629Z","caller":"traceutil/trace.go:171","msg":"trace[1321570741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1841; }","duration":"120.422043ms","start":"2026-06-06T05:09:03.948183Z","end":"2026-06-06T05:09:04.068605Z","steps":["trace[1321570741] 'range keys from in-memory index tree' (duration: 120.044604ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:09:04.076201Z","caller":"traceutil/trace.go:171","msg":"trace[688268600] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"113.682052ms","start":"2026-06-06T05:09:03.962498Z","end":"2026-06-06T05:09:04.07618Z","steps":["trace[688268600] 'process raft request' (duration: 113.549219ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:09:04.076238Z","caller":"traceutil/trace.go:171","msg":"trace[1810344224] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1915; }","duration":"112.398541ms","start":"2026-06-06T05:09:03.963802Z","end":"2026-06-06T05:09:04.0762Z","steps":["trace[1810344224] 'read index received' (duration: 112.35356ms)","trace[1810344224] 'applied index is now lower than readState.Index' (duration: 41.541µs)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:09:04.076712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.930755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53d66753-cdbe-4813-8685-1f29cef8a46d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-06T05:09:04.07681Z","caller":"traceutil/trace.go:171","msg":"trace[887184353] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53d66753-cdbe-4813-8685-1f29cef8a46d; range_end:; response_count:1; response_revision:1842; }","duration":"113.100089ms","start":"2026-06-06T05:09:03.963688Z","end":"2026-06-06T05:09:04.076788Z","steps":["trace[887184353] 'agreement among raft nodes before linearized reading' (duration: 112.637867ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:09:04.408717Z","caller":"traceutil/trace.go:171","msg":"trace[741080308] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"103.113661ms","start":"2026-06-06T05:09:04.305579Z","end":"2026-06-06T05:09:04.408692Z","steps":["trace[741080308] 'process raft request' (duration: 102.938267ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:09:20.020949Z","caller":"traceutil/trace.go:171","msg":"trace[483382379] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"118.012955ms","start":"2026-06-06T05:09:19.902916Z","end":"2026-06-06T05:09:20.020929Z","steps":["trace[483382379] 'process raft request' (duration: 117.886622ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:09:54.398794Z","caller":"traceutil/trace.go:171","msg":"trace[1926385856] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"140.50186ms","start":"2026-06-06T05:09:54.25826Z","end":"2026-06-06T05:09:54.398762Z","steps":["trace[1926385856] 'process raft request' (duration: 140.297955ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:10:00.085453Z","caller":"traceutil/trace.go:171","msg":"trace[1524911300] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"159.155012ms","start":"2026-06-06T05:09:59.926269Z","end":"2026-06-06T05:10:00.085424Z","steps":["trace[1524911300] 'read index received' (duration: 64.127992ms)","trace[1524911300] 'applied index is now lower than readState.Index' (duration: 95.02601ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:10:00.085714Z","caller":"traceutil/trace.go:171","msg":"trace[564516840] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"186.17713ms","start":"2026-06-06T05:09:59.899523Z","end":"2026-06-06T05:10:00.0857Z","steps":["trace[564516840] 'process raft request' (duration: 90.958084ms)","trace[564516840] 'compare' (duration: 94.772155ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:10:00.08603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.754827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-06T05:10:00.086076Z","caller":"traceutil/trace.go:171","msg":"trace[2137544241] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2193; }","duration":"159.848339ms","start":"2026-06-06T05:09:59.926214Z","end":"2026-06-06T05:10:00.086062Z","steps":["trace[2137544241] 'agreement among raft nodes before linearized reading' (duration: 159.656925ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:10:43.359728Z","caller":"traceutil/trace.go:171","msg":"trace[954880594] linearizableReadLoop","detail":"{readStateIndex:2704; appliedIndex:2703; }","duration":"218.461431ms","start":"2026-06-06T05:10:43.141248Z","end":"2026-06-06T05:10:43.35971Z","steps":["trace[954880594] 'read index received' (duration: 218.363329ms)","trace[954880594] 'applied index is now lower than readState.Index' (duration: 95.122µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:10:43.35979Z","caller":"traceutil/trace.go:171","msg":"trace[1553964998] transaction","detail":"{read_only:false; response_revision:2602; number_of_response:1; }","duration":"268.736155ms","start":"2026-06-06T05:10:43.091005Z","end":"2026-06-06T05:10:43.359742Z","steps":["trace[1553964998] 'process raft request' (duration: 268.566371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:10:43.359857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.581063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:10:43.359917Z","caller":"traceutil/trace.go:171","msg":"trace[1608948162] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2602; }","duration":"218.703587ms","start":"2026-06-06T05:10:43.1412Z","end":"2026-06-06T05:10:43.359903Z","steps":["trace[1608948162] 'agreement among raft nodes before linearized reading' (duration: 218.578163ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:11:16.939844Z","caller":"traceutil/trace.go:171","msg":"trace[557638399] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"163.513982ms","start":"2026-06-06T05:11:16.776279Z","end":"2026-06-06T05:11:16.939793Z","steps":["trace[557638399] 'process raft request' (duration: 142.370789ms)","trace[557638399] 'compare' (duration: 20.853146ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:11:17.25363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.235824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T05:11:17.253741Z","caller":"traceutil/trace.go:171","msg":"trace[626250231] linearizableReadLoop","detail":"{readStateIndex:2917; appliedIndex:2916; }","duration":"247.08693ms","start":"2026-06-06T05:11:17.006638Z","end":"2026-06-06T05:11:17.253725Z","steps":["trace[626250231] 'read index received' (duration: 120.030967ms)","trace[626250231] 'applied index is now lower than readState.Index' (duration: 127.054393ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:11:17.253877Z","caller":"traceutil/trace.go:171","msg":"trace[663375386] transaction","detail":"{read_only:false; response_revision:2807; number_of_response:1; }","duration":"281.947491ms","start":"2026-06-06T05:11:16.971872Z","end":"2026-06-06T05:11:17.253819Z","steps":["trace[663375386] 'process raft request' (duration: 154.726162ms)","trace[663375386] 'compare' (duration: 125.974888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:11:17.254251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.513507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-06T05:11:17.254304Z","caller":"traceutil/trace.go:171","msg":"trace[984928820] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2807; }","duration":"217.61748ms","start":"2026-06-06T05:11:17.036675Z","end":"2026-06-06T05:11:17.254292Z","steps":["trace[984928820] 'agreement among raft nodes before linearized reading' (duration: 217.473796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:11:17.258818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.495111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-06T05:11:17.258883Z","caller":"traceutil/trace.go:171","msg":"trace[2011544487] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2807; }","duration":"252.269724ms","start":"2026-06-06T05:11:17.006602Z","end":"2026-06-06T05:11:17.258871Z","steps":["trace[2011544487] 'agreement among raft nodes before linearized reading' (duration: 247.206884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:11:17.259071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.776159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-06-06T05:11:17.259114Z","caller":"traceutil/trace.go:171","msg":"trace[1682293303] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2807; }","duration":"119.862001ms","start":"2026-06-06T05:11:17.13924Z","end":"2026-06-06T05:11:17.259102Z","steps":["trace[1682293303] 'agreement among raft nodes before linearized reading' (duration: 114.957935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:11:17.259348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.668231ms","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-06-06T05:11:17.259383Z","caller":"traceutil/trace.go:171","msg":"trace[2015822571] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2807; }","duration":"125.741403ms","start":"2026-06-06T05:11:17.133626Z","end":"2026-06-06T05:11:17.259367Z","steps":["trace[2015822571] 'agreement among raft nodes before linearized reading' (duration: 120.57913ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:11:17.413303Z","caller":"traceutil/trace.go:171","msg":"trace[1956226589] linearizableReadLoop","detail":"{readStateIndex:2919; appliedIndex:2917; }","duration":"145.253777ms","start":"2026-06-06T05:11:17.268026Z","end":"2026-06-06T05:11:17.413279Z","steps":["trace[1956226589] 'read index received' (duration: 136.439727ms)","trace[1956226589] 'applied index is now lower than readState.Index' (duration: 8.81288ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:11:17.413329Z","caller":"traceutil/trace.go:171","msg":"trace[954238606] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"148.141706ms","start":"2026-06-06T05:11:17.265162Z","end":"2026-06-06T05:11:17.413304Z","steps":["trace[954238606] 'process raft request' (duration: 139.200313ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:11:17.413376Z","caller":"traceutil/trace.go:171","msg":"trace[232685581] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"148.087823ms","start":"2026-06-06T05:11:17.265252Z","end":"2026-06-06T05:11:17.41334Z","steps":["trace[232685581] 'process raft request' (duration: 147.987971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:11:17.413609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.577285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7462"} {"level":"info","ts":"2026-06-06T05:11:17.413662Z","caller":"traceutil/trace.go:171","msg":"trace[195105358] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2809; }","duration":"145.692508ms","start":"2026-06-06T05:11:17.267959Z","end":"2026-06-06T05:11:17.413651Z","steps":["trace[195105358] 'agreement among raft nodes before linearized reading' (duration: 145.42266ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:19.153861Z","caller":"traceutil/trace.go:171","msg":"trace[1455972675] linearizableReadLoop","detail":"{readStateIndex:5217; appliedIndex:5216; }","duration":"152.70198ms","start":"2026-06-06T05:15:19.001128Z","end":"2026-06-06T05:15:19.15383Z","steps":["trace[1455972675] 'read index received' (duration: 110.357747ms)","trace[1455972675] 'applied index is now lower than readState.Index' (duration: 42.343123ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:15:19.154042Z","caller":"traceutil/trace.go:171","msg":"trace[267234260] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"160.809965ms","start":"2026-06-06T05:15:18.993212Z","end":"2026-06-06T05:15:19.154022Z","steps":["trace[267234260] 'process raft request' (duration: 118.336589ms)","trace[267234260] 'compare' (duration: 42.123628ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:15:19.154227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.355614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-06T05:15:19.15436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.556578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-hcq5h-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-06-06T05:15:19.154304Z","caller":"traceutil/trace.go:171","msg":"trace[260229837] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5024; }","duration":"150.456706ms","start":"2026-06-06T05:15:19.003828Z","end":"2026-06-06T05:15:19.154284Z","steps":["trace[260229837] 'agreement among raft nodes before linearized reading' (duration: 150.20622ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:19.154385Z","caller":"traceutil/trace.go:171","msg":"trace[1404467807] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-hcq5h-tls; range_end:; response_count:1; response_revision:5024; }","duration":"114.62746ms","start":"2026-06-06T05:15:19.039752Z","end":"2026-06-06T05:15:19.154379Z","steps":["trace[1404467807] 'agreement among raft nodes before linearized reading' (duration: 114.526098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:15:19.154488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.325626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6f877cc7-3981-42fa-ae0b-751272f41933\" ","response":"range_response_count:1 size:3718"} {"level":"info","ts":"2026-06-06T05:15:19.154592Z","caller":"traceutil/trace.go:171","msg":"trace[1670952897] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6f877cc7-3981-42fa-ae0b-751272f41933; range_end:; response_count:1; response_revision:5024; }","duration":"153.471839ms","start":"2026-06-06T05:15:19.001098Z","end":"2026-06-06T05:15:19.154569Z","steps":["trace[1670952897] 'agreement among raft nodes before linearized reading' (duration: 153.161401ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:31.320053Z","caller":"traceutil/trace.go:171","msg":"trace[1343027314] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"235.100701ms","start":"2026-06-06T05:15:31.084927Z","end":"2026-06-06T05:15:31.320028Z","steps":["trace[1343027314] 'process raft request' (duration: 234.590409ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:31.320096Z","caller":"traceutil/trace.go:171","msg":"trace[334371125] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"235.0591ms","start":"2026-06-06T05:15:31.085021Z","end":"2026-06-06T05:15:31.32008Z","steps":["trace[334371125] 'process raft request' (duration: 234.940998ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:31.320137Z","caller":"traceutil/trace.go:171","msg":"trace[935505158] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"234.836205ms","start":"2026-06-06T05:15:31.085296Z","end":"2026-06-06T05:15:31.320132Z","steps":["trace[935505158] 'process raft request' (duration: 234.697451ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:31.320347Z","caller":"traceutil/trace.go:171","msg":"trace[620465864] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"225.436558ms","start":"2026-06-06T05:15:31.094899Z","end":"2026-06-06T05:15:31.320335Z","steps":["trace[620465864] 'process raft request' (duration: 225.144601ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:15:38.726576Z","caller":"traceutil/trace.go:171","msg":"trace[281449692] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"125.37862ms","start":"2026-06-06T05:15:38.601157Z","end":"2026-06-06T05:15:38.726535Z","steps":["trace[281449692] 'process raft request' (duration: 78.59537ms)","trace[281449692] 'compare' (duration: 46.495384ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:15:38.880748Z","caller":"traceutil/trace.go:171","msg":"trace[1547906009] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"129.946621ms","start":"2026-06-06T05:15:38.750773Z","end":"2026-06-06T05:15:38.88072Z","steps":["trace[1547906009] 'process raft request' (duration: 83.814926ms)","trace[1547906009] 'compare' (duration: 45.965251ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:15:50.451408Z","caller":"traceutil/trace.go:171","msg":"trace[1700965471] linearizableReadLoop","detail":"{readStateIndex:5798; appliedIndex:5797; }","duration":"108.471532ms","start":"2026-06-06T05:15:50.342906Z","end":"2026-06-06T05:15:50.451378Z","steps":["trace[1700965471] 'read index received' (duration: 46.914044ms)","trace[1700965471] 'applied index is now lower than readState.Index' (duration: 61.556148ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:15:50.451471Z","caller":"traceutil/trace.go:171","msg":"trace[709481650] transaction","detail":"{read_only:false; response_revision:5590; number_of_response:1; }","duration":"135.478313ms","start":"2026-06-06T05:15:50.315951Z","end":"2026-06-06T05:15:50.45143Z","steps":["trace[709481650] 'process raft request' (duration: 73.967697ms)","trace[709481650] 'compare' (duration: 61.275811ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:15:50.451862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.923273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-41def88e-7a78-4a3c-a291-d0c035277d20\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-06T05:15:50.451983Z","caller":"traceutil/trace.go:171","msg":"trace[680114272] range","detail":"{range_begin:/registry/persistentvolumes/pvc-41def88e-7a78-4a3c-a291-d0c035277d20; range_end:; response_count:1; response_revision:5590; }","duration":"109.121607ms","start":"2026-06-06T05:15:50.342835Z","end":"2026-06-06T05:15:50.451957Z","steps":["trace[680114272] 'agreement among raft nodes before linearized reading' (duration: 108.718497ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:16:42.760821Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2946} {"level":"info","ts":"2026-06-06T05:16:42.895815Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2946,"took":"132.86825ms","hash":4051267109,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":33853440,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-06T05:16:42.895894Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4051267109,"revision":2946,"compact-revision":-1} {"level":"warn","ts":"2026-06-06T05:21:42.581403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.267596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:21:42.581538Z","caller":"traceutil/trace.go:171","msg":"trace[809853526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8242; }","duration":"133.44537ms","start":"2026-06-06T05:21:42.448073Z","end":"2026-06-06T05:21:42.581518Z","steps":["trace[809853526] 'range keys from in-memory index tree' (duration: 133.195485ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:21:42.769475Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6026} {"level":"info","ts":"2026-06-06T05:21:42.861092Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6026,"took":"90.273988ms","hash":3804790954,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":23302144,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-06T05:21:42.861163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3804790954,"revision":6026,"compact-revision":2946} {"level":"info","ts":"2026-06-06T05:21:54.986552Z","caller":"traceutil/trace.go:171","msg":"trace[985366674] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"141.971321ms","start":"2026-06-06T05:21:54.844556Z","end":"2026-06-06T05:21:54.986528Z","steps":["trace[985366674] 'process raft request' (duration: 141.826697ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:21:55.278041Z","caller":"traceutil/trace.go:171","msg":"trace[1526095151] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"103.647158ms","start":"2026-06-06T05:21:55.174368Z","end":"2026-06-06T05:21:55.278015Z","steps":["trace[1526095151] 'process raft request' (duration: 103.472884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:22:23.12953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.612625ms","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-06-06T05:22:23.129632Z","caller":"traceutil/trace.go:171","msg":"trace[789213094] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8516; }","duration":"383.795419ms","start":"2026-06-06T05:22:22.745817Z","end":"2026-06-06T05:22:23.129612Z","steps":["trace[789213094] 'range keys from in-memory index tree' (duration: 383.314136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:22:23.129667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.818395ms","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-06-06T05:22:23.129746Z","caller":"traceutil/trace.go:171","msg":"trace[1502199170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8516; }","duration":"333.983899ms","start":"2026-06-06T05:22:22.79575Z","end":"2026-06-06T05:22:23.129734Z","steps":["trace[1502199170] 'range keys from in-memory index tree' (duration: 333.548079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:22:23.129775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:22:22.795728Z","time spent":"334.04162ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-06T05:22:23.129675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:22:22.745779Z","time spent":"383.886641ms","remote":"127.0.0.1:51970","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-06-06T05:22:26.395186Z","caller":"traceutil/trace.go:171","msg":"trace[1863051996] transaction","detail":"{read_only:false; response_revision:8535; number_of_response:1; }","duration":"167.267071ms","start":"2026-06-06T05:22:26.227902Z","end":"2026-06-06T05:22:26.395169Z","steps":["trace[1863051996] 'process raft request' (duration: 167.061447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:22:35.758809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.940929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T05:22:35.75901Z","caller":"traceutil/trace.go:171","msg":"trace[430174573] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"171.071303ms","start":"2026-06-06T05:22:35.587918Z","end":"2026-06-06T05:22:35.75899Z","steps":["trace[430174573] 'process raft request' (duration: 170.991731ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:22:35.759039Z","caller":"traceutil/trace.go:171","msg":"trace[2005840534] linearizableReadLoop","detail":"{readStateIndex:8934; appliedIndex:8933; }","duration":"171.287497ms","start":"2026-06-06T05:22:35.587716Z","end":"2026-06-06T05:22:35.759004Z","steps":["trace[2005840534] 'read index received' (duration: 49.196245ms)","trace[2005840534] 'applied index is now lower than readState.Index' (duration: 122.083762ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:22:35.759081Z","caller":"traceutil/trace.go:171","msg":"trace[101091428] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"197.581952ms","start":"2026-06-06T05:22:35.561465Z","end":"2026-06-06T05:22:35.759047Z","steps":["trace[101091428] 'process raft request' (duration: 75.330416ms)","trace[101091428] 'compare' (duration: 121.836506ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:22:35.759312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.584525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-c25x9\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-06-06T05:22:35.759374Z","caller":"traceutil/trace.go:171","msg":"trace[1188887719] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-c25x9; range_end:; response_count:1; response_revision:8626; }","duration":"171.679107ms","start":"2026-06-06T05:22:35.587679Z","end":"2026-06-06T05:22:35.759358Z","steps":["trace[1188887719] 'agreement among raft nodes before linearized reading' (duration: 171.489832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:22:35.759459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.20771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-06T05:22:35.759512Z","caller":"traceutil/trace.go:171","msg":"trace[391288357] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:8626; }","duration":"121.321013ms","start":"2026-06-06T05:22:35.638176Z","end":"2026-06-06T05:22:35.759497Z","steps":["trace[391288357] 'agreement among raft nodes before linearized reading' (duration: 121.115778ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:22:35.912764Z","caller":"traceutil/trace.go:171","msg":"trace[2060739653] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"146.894771ms","start":"2026-06-06T05:22:35.765846Z","end":"2026-06-06T05:22:35.912741Z","steps":["trace[2060739653] 'process raft request' (duration: 146.750057ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:22:35.918588Z","caller":"traceutil/trace.go:171","msg":"trace[1557889483] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"100.635736ms","start":"2026-06-06T05:22:35.817923Z","end":"2026-06-06T05:22:35.918559Z","steps":["trace[1557889483] 'process raft request' (duration: 100.470782ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:22:36.821316Z","caller":"traceutil/trace.go:171","msg":"trace[1204893945] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"133.488588ms","start":"2026-06-06T05:22:36.687786Z","end":"2026-06-06T05:22:36.821275Z","steps":["trace[1204893945] 'process raft request' (duration: 112.606534ms)","trace[1204893945] 'compare' (duration: 20.208108ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:22:52.663446Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002397.wal"} {"level":"info","ts":"2026-06-06T05:23:45.737472Z","caller":"traceutil/trace.go:171","msg":"trace[10380112] transaction","detail":"{read_only:false; response_revision:9341; number_of_response:1; }","duration":"103.887294ms","start":"2026-06-06T05:23:45.633553Z","end":"2026-06-06T05:23:45.737441Z","steps":["trace[10380112] 'process raft request' (duration: 87.071808ms)","trace[10380112] 'compare' (duration: 16.608961ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:24:29.730916Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-06T05:24:29.737255Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-06T05:24:29.737339Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-06T05:26:42.776749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8246} {"level":"info","ts":"2026-06-06T05:26:42.857941Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8246,"took":"78.877172ms","hash":478498015,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":26464256,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-06T05:26:42.858062Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":478498015,"revision":8246,"compact-revision":6026} {"level":"info","ts":"2026-06-06T05:31:42.781475Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10739} {"level":"info","ts":"2026-06-06T05:31:42.861248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10739,"took":"77.876568ms","hash":27648974,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":27832320,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-06T05:31:42.861306Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":27648974,"revision":10739,"compact-revision":8246} {"level":"info","ts":"2026-06-06T05:33:48.219417Z","caller":"traceutil/trace.go:171","msg":"trace[1057596003] transaction","detail":"{read_only:false; response_revision:13752; number_of_response:1; }","duration":"330.586906ms","start":"2026-06-06T05:33:47.888806Z","end":"2026-06-06T05:33:48.219393Z","steps":["trace[1057596003] 'process raft request' (duration: 330.414382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:33:48.219589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:33:47.888784Z","time spent":"330.718189ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:33:48.287851Z","caller":"traceutil/trace.go:171","msg":"trace[1890933091] linearizableReadLoop","detail":"{readStateIndex:14227; appliedIndex:14225; }","duration":"281.724138ms","start":"2026-06-06T05:33:48.006101Z","end":"2026-06-06T05:33:48.287825Z","steps":["trace[1890933091] 'read index received' (duration: 213.185424ms)","trace[1890933091] 'applied index is now lower than readState.Index' (duration: 68.537714ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:33:48.287932Z","caller":"traceutil/trace.go:171","msg":"trace[1527205031] transaction","detail":"{read_only:false; response_revision:13753; number_of_response:1; }","duration":"332.428741ms","start":"2026-06-06T05:33:47.955471Z","end":"2026-06-06T05:33:48.2879Z","steps":["trace[1527205031] 'process raft request' (duration: 324.639222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:33:48.28809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:33:47.955444Z","time spent":"332.558764ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:33:48.288095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.982284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-06T05:33:48.288144Z","caller":"traceutil/trace.go:171","msg":"trace[424949558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13753; }","duration":"282.088286ms","start":"2026-06-06T05:33:48.006045Z","end":"2026-06-06T05:33:48.288133Z","steps":["trace[424949558] 'agreement among raft nodes before linearized reading' (duration: 281.922602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:33:48.288212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.701569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-dgl47\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-06-06T05:33:48.288267Z","caller":"traceutil/trace.go:171","msg":"trace[2029675947] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-dgl47; range_end:; response_count:1; response_revision:13753; }","duration":"199.788461ms","start":"2026-06-06T05:33:48.088464Z","end":"2026-06-06T05:33:48.288253Z","steps":["trace[2029675947] 'agreement among raft nodes before linearized reading' (duration: 199.589906ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:33:49.340011Z","caller":"traceutil/trace.go:171","msg":"trace[353154376] transaction","detail":"{read_only:false; response_revision:13763; number_of_response:1; }","duration":"108.324984ms","start":"2026-06-06T05:33:49.231635Z","end":"2026-06-06T05:33:49.33996Z","steps":["trace[353154376] 'process raft request' (duration: 11.16088ms)","trace[353154376] 'compare' (duration: 96.685913ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:34:09.642621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.698901ms","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-06-06T05:34:09.642761Z","caller":"traceutil/trace.go:171","msg":"trace[1764238348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14056; }","duration":"173.908156ms","start":"2026-06-06T05:34:09.468828Z","end":"2026-06-06T05:34:09.642736Z","steps":["trace[1764238348] 'range keys from in-memory index tree' (duration: 173.499305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:34:09.642933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.702791ms","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-06-06T05:34:09.64297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.388277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-387c6e8e-7a8f-4bfa-b5f4-6138f3d14ea6\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-06T05:34:09.643002Z","caller":"traceutil/trace.go:171","msg":"trace[187355408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14056; }","duration":"202.798624ms","start":"2026-06-06T05:34:09.44019Z","end":"2026-06-06T05:34:09.642989Z","steps":["trace[187355408] 'range keys from in-memory index tree' (duration: 202.595888ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:34:09.643036Z","caller":"traceutil/trace.go:171","msg":"trace[1282855215] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-387c6e8e-7a8f-4bfa-b5f4-6138f3d14ea6; range_end:; response_count:1; response_revision:14056; }","duration":"290.490179ms","start":"2026-06-06T05:34:09.352527Z","end":"2026-06-06T05:34:09.643017Z","steps":["trace[1282855215] 'range keys from in-memory index tree' (duration: 290.274244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:34:09.64304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.143073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-06T05:34:09.64313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.74288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-06T05:34:09.643139Z","caller":"traceutil/trace.go:171","msg":"trace[1897473081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14056; }","duration":"196.310387ms","start":"2026-06-06T05:34:09.446806Z","end":"2026-06-06T05:34:09.643117Z","steps":["trace[1897473081] 'range keys from in-memory index tree' (duration: 196.041719ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:34:09.643202Z","caller":"traceutil/trace.go:171","msg":"trace[791340943] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14056; }","duration":"175.837572ms","start":"2026-06-06T05:34:09.467346Z","end":"2026-06-06T05:34:09.643183Z","steps":["trace[791340943] 'range keys from in-memory index tree' (duration: 175.595797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:34:09.643284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.626357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-387c6e8e-7a8f-4bfa-b5f4-6138f3d14ea6\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-06T05:34:09.64332Z","caller":"traceutil/trace.go:171","msg":"trace[1086872788] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-387c6e8e-7a8f-4bfa-b5f4-6138f3d14ea6; range_end:; response_count:1; response_revision:14056; }","duration":"221.694858ms","start":"2026-06-06T05:34:09.421613Z","end":"2026-06-06T05:34:09.643308Z","steps":["trace[1086872788] 'range keys from in-memory index tree' (duration: 221.495864ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:35:01.28877Z","caller":"traceutil/trace.go:171","msg":"trace[1916730448] transaction","detail":"{read_only:false; response_revision:14686; number_of_response:1; }","duration":"123.894516ms","start":"2026-06-06T05:35:01.164833Z","end":"2026-06-06T05:35:01.288727Z","steps":["trace[1916730448] 'process raft request' (duration: 123.473935ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:35:35.500326Z","caller":"traceutil/trace.go:171","msg":"trace[1993131932] linearizableReadLoop","detail":"{readStateIndex:15377; appliedIndex:15376; }","duration":"109.920179ms","start":"2026-06-06T05:35:35.390385Z","end":"2026-06-06T05:35:35.500305Z","steps":["trace[1993131932] 'read index received' (duration: 94.932µs)","trace[1993131932] 'applied index is now lower than readState.Index' (duration: 109.824397ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:35:35.500481Z","caller":"traceutil/trace.go:171","msg":"trace[1154502983] transaction","detail":"{read_only:false; response_revision:14866; number_of_response:1; }","duration":"110.064633ms","start":"2026-06-06T05:35:35.390365Z","end":"2026-06-06T05:35:35.50043Z","steps":["trace[1154502983] 'process raft request' (duration: 109.807457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:35:35.500563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.160494ms","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-06-06T05:35:35.5006Z","caller":"traceutil/trace.go:171","msg":"trace[1628504021] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14866; }","duration":"110.230307ms","start":"2026-06-06T05:35:35.390359Z","end":"2026-06-06T05:35:35.500589Z","steps":["trace[1628504021] 'agreement among raft nodes before linearized reading' (duration: 110.131924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:35:35.500858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.410547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-06-06T05:35:35.500918Z","caller":"traceutil/trace.go:171","msg":"trace[154825982] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14866; }","duration":"109.483029ms","start":"2026-06-06T05:35:35.391418Z","end":"2026-06-06T05:35:35.500901Z","steps":["trace[154825982] 'agreement among raft nodes before linearized reading' (duration: 109.332055ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:35:41.118218Z","caller":"traceutil/trace.go:171","msg":"trace[937495905] linearizableReadLoop","detail":"{readStateIndex:15407; appliedIndex:15406; }","duration":"124.800588ms","start":"2026-06-06T05:35:40.993391Z","end":"2026-06-06T05:35:41.118192Z","steps":["trace[937495905] 'read index received' (duration: 118.66515ms)","trace[937495905] 'applied index is now lower than readState.Index' (duration: 6.134058ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:35:41.118289Z","caller":"traceutil/trace.go:171","msg":"trace[1737970107] transaction","detail":"{read_only:false; response_revision:14894; number_of_response:1; }","duration":"129.86853ms","start":"2026-06-06T05:35:40.988377Z","end":"2026-06-06T05:35:41.118245Z","steps":["trace[1737970107] 'process raft request' (duration: 123.703272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:35:41.118454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.036683ms","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-06-06T05:35:41.118501Z","caller":"traceutil/trace.go:171","msg":"trace[982188820] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14894; }","duration":"125.122015ms","start":"2026-06-06T05:35:40.993364Z","end":"2026-06-06T05:35:41.118486Z","steps":["trace[982188820] 'agreement among raft nodes before linearized reading' (duration: 124.964181ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:36:42.790097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12922} {"level":"info","ts":"2026-06-06T05:36:42.874794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12922,"took":"81.821822ms","hash":1282315834,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":30871552,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-06T05:36:42.875163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1282315834,"revision":12922,"compact-revision":10739} {"level":"info","ts":"2026-06-06T05:41:07.548412Z","caller":"traceutil/trace.go:171","msg":"trace[797207980] linearizableReadLoop","detail":"{readStateIndex:17963; appliedIndex:17962; }","duration":"185.511393ms","start":"2026-06-06T05:41:07.362873Z","end":"2026-06-06T05:41:07.548384Z","steps":["trace[797207980] 'read index received' (duration: 185.248356ms)","trace[797207980] 'applied index is now lower than readState.Index' (duration: 262.177µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:41:07.54859Z","caller":"traceutil/trace.go:171","msg":"trace[576381850] transaction","detail":"{read_only:false; response_revision:17370; number_of_response:1; }","duration":"248.267506ms","start":"2026-06-06T05:41:07.300266Z","end":"2026-06-06T05:41:07.548533Z","steps":["trace[576381850] 'process raft request' (duration: 247.931778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:41:07.548675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.78324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"warn","ts":"2026-06-06T05:41:07.548678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.266692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:41:07.548729Z","caller":"traceutil/trace.go:171","msg":"trace[462970658] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:17370; }","duration":"185.901202ms","start":"2026-06-06T05:41:07.362813Z","end":"2026-06-06T05:41:07.548714Z","steps":["trace[462970658] 'agreement among raft nodes before linearized reading' (duration: 185.718988ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:41:07.548791Z","caller":"traceutil/trace.go:171","msg":"trace[1952711059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17370; }","duration":"101.427396ms","start":"2026-06-06T05:41:07.447337Z","end":"2026-06-06T05:41:07.548764Z","steps":["trace[1952711059] 'agreement among raft nodes before linearized reading' (duration: 101.240261ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:41:08.171499Z","caller":"traceutil/trace.go:171","msg":"trace[434830094] transaction","detail":"{read_only:false; response_revision:17373; number_of_response:1; }","duration":"285.021073ms","start":"2026-06-06T05:41:07.886453Z","end":"2026-06-06T05:41:08.171474Z","steps":["trace[434830094] 'process raft request' (duration: 284.970762ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:41:08.171798Z","caller":"traceutil/trace.go:171","msg":"trace[1521456855] transaction","detail":"{read_only:false; response_revision:17372; number_of_response:1; }","duration":"285.464913ms","start":"2026-06-06T05:41:07.886263Z","end":"2026-06-06T05:41:08.171728Z","steps":["trace[1521456855] 'process raft request' (duration: 285.028563ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:41:08.184192Z","caller":"traceutil/trace.go:171","msg":"trace[419207831] transaction","detail":"{read_only:false; response_revision:17374; number_of_response:1; }","duration":"250.636743ms","start":"2026-06-06T05:41:07.933533Z","end":"2026-06-06T05:41:08.18417Z","steps":["trace[419207831] 'process raft request' (duration: 249.831534ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:41:08.434978Z","caller":"traceutil/trace.go:171","msg":"trace[2012664835] transaction","detail":"{read_only:false; response_revision:17376; number_of_response:1; }","duration":"184.574081ms","start":"2026-06-06T05:41:08.250375Z","end":"2026-06-06T05:41:08.43495Z","steps":["trace[2012664835] 'process raft request' (duration: 153.280897ms)","trace[2012664835] 'compare' (duration: 30.965536ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:41:42.796398Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15307} {"level":"info","ts":"2026-06-06T05:41:42.896723Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15307,"took":"96.879465ms","hash":513464453,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":32661504,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-06T05:41:42.896792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":513464453,"revision":15307,"compact-revision":12922} {"level":"info","ts":"2026-06-06T05:45:04.563314Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-06T05:45:04.571354Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-06T05:45:04.571517Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-06T05:46:33.258541Z","caller":"traceutil/trace.go:171","msg":"trace[1571411002] linearizableReadLoop","detail":"{readStateIndex:20615; appliedIndex:20614; }","duration":"141.607274ms","start":"2026-06-06T05:46:33.116907Z","end":"2026-06-06T05:46:33.258514Z","steps":["trace[1571411002] 'read index received' (duration: 141.422129ms)","trace[1571411002] 'applied index is now lower than readState.Index' (duration: 184.025µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:46:33.258962Z","caller":"traceutil/trace.go:171","msg":"trace[20645183] transaction","detail":"{read_only:false; response_revision:19938; number_of_response:1; }","duration":"218.309505ms","start":"2026-06-06T05:46:33.040612Z","end":"2026-06-06T05:46:33.258922Z","steps":["trace[20645183] 'process raft request' (duration: 217.6947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:46:33.364697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.794305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-06T05:46:33.36476Z","caller":"traceutil/trace.go:171","msg":"trace[1131421433] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:19938; }","duration":"247.904197ms","start":"2026-06-06T05:46:33.11684Z","end":"2026-06-06T05:46:33.364744Z","steps":["trace[1131421433] 'agreement among raft nodes before linearized reading' (duration: 141.996554ms)","trace[1131421433] 'range keys from in-memory index tree' (duration: 105.727179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:46:33.36513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.472074ms","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-06-06T05:46:33.365233Z","caller":"traceutil/trace.go:171","msg":"trace[221285836] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:19938; }","duration":"217.601327ms","start":"2026-06-06T05:46:33.147607Z","end":"2026-06-06T05:46:33.365208Z","steps":["trace[221285836] 'agreement among raft nodes before linearized reading' (duration: 111.484309ms)","trace[221285836] 'count revisions from in-memory index tree' (duration: 105.947745ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:46:33.803547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.07708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:46:33.803674Z","caller":"traceutil/trace.go:171","msg":"trace[696370871] transaction","detail":"{read_only:false; response_revision:19941; number_of_response:1; }","duration":"248.145933ms","start":"2026-06-06T05:46:33.555501Z","end":"2026-06-06T05:46:33.803647Z","steps":["trace[696370871] 'process raft request' (duration: 126.903549ms)","trace[696370871] 'compare' (duration: 120.984938ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:46:33.826271Z","caller":"traceutil/trace.go:171","msg":"trace[96460070] transaction","detail":"{read_only:false; response_revision:19942; number_of_response:1; }","duration":"210.647319ms","start":"2026-06-06T05:46:33.6156Z","end":"2026-06-06T05:46:33.826247Z","steps":["trace[96460070] 'process raft request' (duration: 210.272821ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:46:34.084215Z","caller":"traceutil/trace.go:171","msg":"trace[785359970] transaction","detail":"{read_only:false; response_revision:19943; number_of_response:1; }","duration":"253.262467ms","start":"2026-06-06T05:46:33.830933Z","end":"2026-06-06T05:46:34.084195Z","steps":["trace[785359970] 'process raft request' (duration: 253.141534ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:46:34.173864Z","caller":"traceutil/trace.go:171","msg":"trace[1343530323] linearizableReadLoop","detail":"{readStateIndex:20623; appliedIndex:20620; }","duration":"226.618914ms","start":"2026-06-06T05:46:33.947219Z","end":"2026-06-06T05:46:34.173838Z","steps":["trace[1343530323] 'read index received' (duration: 137.003714ms)","trace[1343530323] 'applied index is now lower than readState.Index' (duration: 89.61423ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:46:34.174023Z","caller":"traceutil/trace.go:171","msg":"trace[2125680964] transaction","detail":"{read_only:false; response_revision:19944; number_of_response:1; }","duration":"341.852933ms","start":"2026-06-06T05:46:33.832131Z","end":"2026-06-06T05:46:34.173984Z","steps":["trace[2125680964] 'process raft request' (duration: 341.471794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:46:34.174263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.029384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-06T05:46:34.17396Z","caller":"traceutil/trace.go:171","msg":"trace[1979152195] transaction","detail":"{read_only:false; response_revision:19945; number_of_response:1; }","duration":"341.636808ms","start":"2026-06-06T05:46:33.832278Z","end":"2026-06-06T05:46:34.173915Z","steps":["trace[1979152195] 'process raft request' (duration: 341.476304ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:46:34.174265Z","caller":"traceutil/trace.go:171","msg":"trace[952943974] transaction","detail":"{read_only:false; response_revision:19946; number_of_response:1; }","duration":"297.690748ms","start":"2026-06-06T05:46:33.876341Z","end":"2026-06-06T05:46:34.174031Z","steps":["trace[952943974] 'process raft request' (duration: 297.462953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:46:34.174374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:46:33.832112Z","time spent":"342.17404ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:46:34.174317Z","caller":"traceutil/trace.go:171","msg":"trace[265798682] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:19946; }","duration":"227.141236ms","start":"2026-06-06T05:46:33.947162Z","end":"2026-06-06T05:46:34.174303Z","steps":["trace[265798682] 'agreement among raft nodes before linearized reading' (duration: 226.776608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:46:34.174437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:46:33.832258Z","time spent":"342.080398ms","remote":"127.0.0.1:52050","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-06-06T05:46:34.429716Z","caller":"traceutil/trace.go:171","msg":"trace[1408118901] transaction","detail":"{read_only:false; response_revision:19947; number_of_response:1; }","duration":"104.646173ms","start":"2026-06-06T05:46:34.325045Z","end":"2026-06-06T05:46:34.429691Z","steps":["trace[1408118901] 'process raft request' (duration: 104.444888ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:46:34.440787Z","caller":"traceutil/trace.go:171","msg":"trace[1501725286] transaction","detail":"{read_only:false; response_revision:19948; number_of_response:1; }","duration":"115.661678ms","start":"2026-06-06T05:46:34.325103Z","end":"2026-06-06T05:46:34.440765Z","steps":["trace[1501725286] 'process raft request' (duration: 115.521645ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:46:42.803481Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17730} {"level":"info","ts":"2026-06-06T05:46:42.905182Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17730,"took":"97.515421ms","hash":3296431416,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":33107968,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-06T05:46:42.90528Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3296431416,"revision":17730,"compact-revision":15307} {"level":"info","ts":"2026-06-06T05:51:07.376418Z","caller":"traceutil/trace.go:171","msg":"trace[1593194950] transaction","detail":"{read_only:false; response_revision:22561; number_of_response:1; }","duration":"164.122117ms","start":"2026-06-06T05:51:07.21227Z","end":"2026-06-06T05:51:07.376392Z","steps":["trace[1593194950] 'process raft request' (duration: 137.774182ms)","trace[1593194950] 'compare' (duration: 26.231853ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:51:42.810683Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19988} {"level":"info","ts":"2026-06-06T05:51:42.921417Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19988,"took":"107.072163ms","hash":4210232916,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":40697856,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-06T05:51:42.921489Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4210232916,"revision":19988,"compact-revision":17730} {"level":"info","ts":"2026-06-06T05:54:23.903948Z","caller":"traceutil/trace.go:171","msg":"trace[1830151438] linearizableReadLoop","detail":"{readStateIndex:25386; appliedIndex:25385; }","duration":"106.212932ms","start":"2026-06-06T05:54:23.797712Z","end":"2026-06-06T05:54:23.903925Z","steps":["trace[1830151438] 'read index received' (duration: 106.177281ms)","trace[1830151438] 'applied index is now lower than readState.Index' (duration: 34.721µs)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:23.904091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.359165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:23.904072Z","caller":"traceutil/trace.go:171","msg":"trace[267127048] transaction","detail":"{read_only:false; response_revision:24579; number_of_response:1; }","duration":"107.070652ms","start":"2026-06-06T05:54:23.796971Z","end":"2026-06-06T05:54:23.904041Z","steps":["trace[267127048] 'process raft request' (duration: 106.782045ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:23.904141Z","caller":"traceutil/trace.go:171","msg":"trace[1087338421] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:24579; }","duration":"106.459838ms","start":"2026-06-06T05:54:23.79767Z","end":"2026-06-06T05:54:23.90413Z","steps":["trace[1087338421] 'agreement among raft nodes before linearized reading' (duration: 106.364975ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:24.057593Z","caller":"traceutil/trace.go:171","msg":"trace[544676654] linearizableReadLoop","detail":"{readStateIndex:25387; appliedIndex:25386; }","duration":"121.248364ms","start":"2026-06-06T05:54:23.936317Z","end":"2026-06-06T05:54:24.057565Z","steps":["trace[544676654] 'read index received' (duration: 121.010668ms)","trace[544676654] 'applied index is now lower than readState.Index' (duration: 236.846µs)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:24.057721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.384017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:24.057756Z","caller":"traceutil/trace.go:171","msg":"trace[517906430] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:24580; }","duration":"121.474309ms","start":"2026-06-06T05:54:23.93627Z","end":"2026-06-06T05:54:24.057745Z","steps":["trace[517906430] 'agreement among raft nodes before linearized reading' (duration: 121.389307ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:24.057788Z","caller":"traceutil/trace.go:171","msg":"trace[1930729885] transaction","detail":"{read_only:false; response_revision:24580; number_of_response:1; }","duration":"152.355323ms","start":"2026-06-06T05:54:23.905392Z","end":"2026-06-06T05:54:24.057747Z","steps":["trace[1930729885] 'process raft request' (duration: 152.001295ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:24.341051Z","caller":"traceutil/trace.go:171","msg":"trace[2079141713] transaction","detail":"{read_only:false; response_revision:24581; number_of_response:1; }","duration":"129.113874ms","start":"2026-06-06T05:54:24.211887Z","end":"2026-06-06T05:54:24.341001Z","steps":["trace[2079141713] 'process raft request' (duration: 128.93523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:25.181801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.365215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:25.18188Z","caller":"traceutil/trace.go:171","msg":"trace[1675455803] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:24589; }","duration":"206.472718ms","start":"2026-06-06T05:54:24.975389Z","end":"2026-06-06T05:54:25.181862Z","steps":["trace[1675455803] 'count revisions from in-memory index tree' (duration: 204.662955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:25.181806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.133545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:25.181991Z","caller":"traceutil/trace.go:171","msg":"trace[1912886952] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:24589; }","duration":"224.375401ms","start":"2026-06-06T05:54:24.957596Z","end":"2026-06-06T05:54:25.181972Z","steps":["trace[1912886952] 'count revisions from in-memory index tree' (duration: 222.66309ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:25.418254Z","caller":"traceutil/trace.go:171","msg":"trace[1642230458] transaction","detail":"{read_only:false; response_revision:24591; number_of_response:1; }","duration":"222.742922ms","start":"2026-06-06T05:54:25.195485Z","end":"2026-06-06T05:54:25.418228Z","steps":["trace[1642230458] 'process raft request' (duration: 180.430492ms)","trace[1642230458] 'compare' (duration: 42.227548ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:25.514217Z","caller":"traceutil/trace.go:171","msg":"trace[1997307437] linearizableReadLoop","detail":"{readStateIndex:25399; appliedIndex:25397; }","duration":"144.29971ms","start":"2026-06-06T05:54:25.369899Z","end":"2026-06-06T05:54:25.514199Z","steps":["trace[1997307437] 'read index received' (duration: 6.071307ms)","trace[1997307437] 'applied index is now lower than readState.Index' (duration: 138.227143ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:25.514251Z","caller":"traceutil/trace.go:171","msg":"trace[1688269265] transaction","detail":"{read_only:false; response_revision:24592; number_of_response:1; }","duration":"315.676733ms","start":"2026-06-06T05:54:25.198549Z","end":"2026-06-06T05:54:25.514226Z","steps":["trace[1688269265] 'process raft request' (duration: 315.54352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:25.514383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.585295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-06T05:54:25.514381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:25.198528Z","time spent":"315.764405ms","remote":"127.0.0.1:52050","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-06-06T05:54:25.514402Z","caller":"traceutil/trace.go:171","msg":"trace[682718839] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24592; }","duration":"124.609115ms","start":"2026-06-06T05:54:25.389787Z","end":"2026-06-06T05:54:25.514397Z","steps":["trace[682718839] 'agreement among raft nodes before linearized reading' (duration: 124.519193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:25.514411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.490385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:25.514479Z","caller":"traceutil/trace.go:171","msg":"trace[1323039221] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:24592; }","duration":"144.607888ms","start":"2026-06-06T05:54:25.369856Z","end":"2026-06-06T05:54:25.514463Z","steps":["trace[1323039221] 'agreement among raft nodes before linearized reading' (duration: 144.449374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:25.641354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.406726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-06T05:54:25.641449Z","caller":"traceutil/trace.go:171","msg":"trace[1329105266] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24592; }","duration":"123.535589ms","start":"2026-06-06T05:54:25.517891Z","end":"2026-06-06T05:54:25.641427Z","steps":["trace[1329105266] 'range keys from in-memory index tree' (duration: 123.216602ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:26.094929Z","caller":"traceutil/trace.go:171","msg":"trace[199633040] transaction","detail":"{read_only:false; response_revision:24595; number_of_response:1; }","duration":"110.012843ms","start":"2026-06-06T05:54:25.984892Z","end":"2026-06-06T05:54:26.094904Z","steps":["trace[199633040] 'process raft request' (duration: 108.072337ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:26.543882Z","caller":"traceutil/trace.go:171","msg":"trace[1129332075] transaction","detail":"{read_only:false; response_revision:24597; number_of_response:1; }","duration":"180.683457ms","start":"2026-06-06T05:54:26.363171Z","end":"2026-06-06T05:54:26.543854Z","steps":["trace[1129332075] 'process raft request' (duration: 180.275797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:26.848827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.433577ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:26.84899Z","caller":"traceutil/trace.go:171","msg":"trace[473197944] transaction","detail":"{read_only:false; response_revision:24599; number_of_response:1; }","duration":"299.209974ms","start":"2026-06-06T05:54:26.549749Z","end":"2026-06-06T05:54:26.848959Z","steps":["trace[473197944] 'process raft request' (duration: 175.539252ms)","trace[473197944] 'compare' (duration: 123.214362ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:26.85895Z","caller":"traceutil/trace.go:171","msg":"trace[585243886] transaction","detail":"{read_only:false; response_revision:24600; number_of_response:1; }","duration":"207.136395ms","start":"2026-06-06T05:54:26.651798Z","end":"2026-06-06T05:54:26.858935Z","steps":["trace[585243886] 'process raft request' (duration: 206.997222ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:26.859115Z","caller":"traceutil/trace.go:171","msg":"trace[1648914672] linearizableReadLoop","detail":"{readStateIndex:25409; appliedIndex:25406; }","duration":"189.828438ms","start":"2026-06-06T05:54:26.669259Z","end":"2026-06-06T05:54:26.859088Z","steps":["trace[1648914672] 'read index received' (duration: 56.685947ms)","trace[1648914672] 'applied index is now lower than readState.Index' (duration: 133.141231ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:26.859193Z","caller":"traceutil/trace.go:171","msg":"trace[987485024] transaction","detail":"{read_only:false; response_revision:24601; number_of_response:1; }","duration":"196.95294ms","start":"2026-06-06T05:54:26.662209Z","end":"2026-06-06T05:54:26.859162Z","steps":["trace[987485024] 'process raft request' (duration: 196.684203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:26.85923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.968832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:26.859274Z","caller":"traceutil/trace.go:171","msg":"trace[529563221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24601; }","duration":"190.050183ms","start":"2026-06-06T05:54:26.669214Z","end":"2026-06-06T05:54:26.859264Z","steps":["trace[529563221] 'agreement among raft nodes before linearized reading' (duration: 189.970291ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:27.162522Z","caller":"traceutil/trace.go:171","msg":"trace[1202463568] linearizableReadLoop","detail":"{readStateIndex:25410; appliedIndex:25409; }","duration":"245.222634ms","start":"2026-06-06T05:54:26.917273Z","end":"2026-06-06T05:54:27.162496Z","steps":["trace[1202463568] 'read index received' (duration: 208.764064ms)","trace[1202463568] 'applied index is now lower than readState.Index' (duration: 36.453559ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:27.162536Z","caller":"traceutil/trace.go:171","msg":"trace[458432229] transaction","detail":"{read_only:false; response_revision:24602; number_of_response:1; }","duration":"245.967191ms","start":"2026-06-06T05:54:26.916538Z","end":"2026-06-06T05:54:27.162506Z","steps":["trace[458432229] 'process raft request' (duration: 209.487701ms)","trace[458432229] 'compare' (duration: 36.278845ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:27.162732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.438479ms","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-06-06T05:54:27.162776Z","caller":"traceutil/trace.go:171","msg":"trace[676328407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24602; }","duration":"245.606792ms","start":"2026-06-06T05:54:26.917159Z","end":"2026-06-06T05:54:27.162766Z","steps":["trace[676328407] 'agreement among raft nodes before linearized reading' (duration: 245.429788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:27.421051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.391523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:27.42125Z","caller":"traceutil/trace.go:171","msg":"trace[659976864] transaction","detail":"{read_only:false; response_revision:24605; number_of_response:1; }","duration":"233.814599ms","start":"2026-06-06T05:54:27.187421Z","end":"2026-06-06T05:54:27.421236Z","steps":["trace[659976864] 'process raft request' (duration: 233.780478ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:27.421567Z","caller":"traceutil/trace.go:171","msg":"trace[1289732796] transaction","detail":"{read_only:false; response_revision:24604; number_of_response:1; }","duration":"255.130823ms","start":"2026-06-06T05:54:27.166401Z","end":"2026-06-06T05:54:27.421532Z","steps":["trace[1289732796] 'process raft request' (duration: 254.733173ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:27.421625Z","caller":"traceutil/trace.go:171","msg":"trace[748822038] transaction","detail":"{read_only:false; response_revision:24603; number_of_response:1; }","duration":"500.598912ms","start":"2026-06-06T05:54:26.920945Z","end":"2026-06-06T05:54:27.421544Z","steps":["trace[748822038] 'process raft request' (duration: 379.642725ms)","trace[748822038] 'compare' (duration: 120.066995ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:27.421809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:26.920934Z","time spent":"500.775607ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:49.831568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.752345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:49.831675Z","caller":"traceutil/trace.go:171","msg":"trace[1034770927] linearizableReadLoop","detail":"{readStateIndex:25578; appliedIndex:25577; }","duration":"330.549601ms","start":"2026-06-06T05:54:49.50111Z","end":"2026-06-06T05:54:49.83166Z","steps":["trace[1034770927] 'read index received' (duration: 99.631863ms)","trace[1034770927] 'applied index is now lower than readState.Index' (duration: 230.916478ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:49.831932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.808229ms","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-06-06T05:54:49.832019Z","caller":"traceutil/trace.go:171","msg":"trace[354880813] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24766; }","duration":"330.905851ms","start":"2026-06-06T05:54:49.501094Z","end":"2026-06-06T05:54:49.832Z","steps":["trace[354880813] 'agreement among raft nodes before linearized reading' (duration: 330.625584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:49.832059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.501051Z","time spent":"330.999243ms","remote":"127.0.0.1:52050","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":"info","ts":"2026-06-06T05:54:49.83201Z","caller":"traceutil/trace.go:171","msg":"trace[91359560] transaction","detail":"{read_only:false; response_revision:24766; number_of_response:1; }","duration":"350.874452ms","start":"2026-06-06T05:54:49.480808Z","end":"2026-06-06T05:54:49.831682Z","steps":["trace[91359560] 'process raft request' (duration: 119.918982ms)","trace[91359560] 'compare' (duration: 230.411187ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:49.832212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.480785Z","time spent":"351.371674ms","remote":"127.0.0.1:52050","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-06-06T05:54:50.101886Z","caller":"traceutil/trace.go:171","msg":"trace[1930732215] transaction","detail":"{read_only:false; response_revision:24768; number_of_response:1; }","duration":"419.609239ms","start":"2026-06-06T05:54:49.682193Z","end":"2026-06-06T05:54:50.101802Z","steps":["trace[1930732215] 'process raft request' (duration: 419.476126ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:50.102898Z","caller":"traceutil/trace.go:171","msg":"trace[380115975] transaction","detail":"{read_only:false; response_revision:24767; number_of_response:1; }","duration":"570.62692ms","start":"2026-06-06T05:54:49.532236Z","end":"2026-06-06T05:54:50.102863Z","steps":["trace[380115975] 'process raft request' (duration: 560.308732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.102937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.682177Z","time spent":"420.667035ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:50.10304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.532207Z","time spent":"570.758243ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:54:50.10416Z","caller":"traceutil/trace.go:171","msg":"trace[1651256785] linearizableReadLoop","detail":"{readStateIndex:25581; appliedIndex:25578; }","duration":"272.41611ms","start":"2026-06-06T05:54:49.8317Z","end":"2026-06-06T05:54:50.104116Z","steps":["trace[1651256785] 'read index received' (duration: 260.367209ms)","trace[1651256785] 'applied index is now lower than readState.Index' (duration: 12.047621ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:50.104521Z","caller":"traceutil/trace.go:171","msg":"trace[1009405005] transaction","detail":"{read_only:false; response_revision:24769; number_of_response:1; }","duration":"422.206302ms","start":"2026-06-06T05:54:49.682291Z","end":"2026-06-06T05:54:50.104497Z","steps":["trace[1009405005] 'process raft request' (duration: 421.626358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.10459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.682284Z","time spent":"422.267653ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:50.104719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.209569ms","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-06-06T05:54:50.104757Z","caller":"traceutil/trace.go:171","msg":"trace[77132290] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24770; }","duration":"227.281601ms","start":"2026-06-06T05:54:49.877461Z","end":"2026-06-06T05:54:50.104743Z","steps":["trace[77132290] 'agreement among raft nodes before linearized reading' (duration: 227.212249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.104708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.917415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-06T05:54:50.104847Z","caller":"traceutil/trace.go:171","msg":"trace[1305597939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24770; }","duration":"427.057828ms","start":"2026-06-06T05:54:49.677771Z","end":"2026-06-06T05:54:50.104829Z","steps":["trace[1305597939] 'agreement among raft nodes before linearized reading' (duration: 426.677829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.104922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.677701Z","time spent":"427.206872ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-06T05:54:50.105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.003817ms","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-06-06T05:54:50.105036Z","caller":"traceutil/trace.go:171","msg":"trace[1865361440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24770; }","duration":"546.080479ms","start":"2026-06-06T05:54:49.558944Z","end":"2026-06-06T05:54:50.105025Z","steps":["trace[1865361440] 'agreement among raft nodes before linearized reading' (duration: 545.970106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.105069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:49.558925Z","time spent":"546.138241ms","remote":"127.0.0.1:52050","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":"warn","ts":"2026-06-06T05:54:50.105174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.09315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-06T05:54:50.105208Z","caller":"traceutil/trace.go:171","msg":"trace[1439154624] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:24770; }","duration":"201.161602ms","start":"2026-06-06T05:54:49.90403Z","end":"2026-06-06T05:54:50.105192Z","steps":["trace[1439154624] 'agreement among raft nodes before linearized reading' (duration: 201.09194ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:50.105167Z","caller":"traceutil/trace.go:171","msg":"trace[647263872] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"268.351811ms","start":"2026-06-06T05:54:49.836794Z","end":"2026-06-06T05:54:50.105145Z","steps":["trace[647263872] 'process raft request' (duration: 267.220955ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:50.847526Z","caller":"traceutil/trace.go:171","msg":"trace[886858766] transaction","detail":"{read_only:false; response_revision:24773; number_of_response:1; }","duration":"692.330006ms","start":"2026-06-06T05:54:50.155167Z","end":"2026-06-06T05:54:50.847497Z","steps":["trace[886858766] 'process raft request' (duration: 692.156071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.847744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.155147Z","time spent":"692.461809ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:54:50.865705Z","caller":"traceutil/trace.go:171","msg":"trace[1335824041] linearizableReadLoop","detail":"{readStateIndex:25586; appliedIndex:25584; }","duration":"505.708846ms","start":"2026-06-06T05:54:50.35997Z","end":"2026-06-06T05:54:50.865678Z","steps":["trace[1335824041] 'read index received' (duration: 487.327472ms)","trace[1335824041] 'applied index is now lower than readState.Index' (duration: 18.380434ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:50.865792Z","caller":"traceutil/trace.go:171","msg":"trace[79917778] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"616.96342ms","start":"2026-06-06T05:54:50.248795Z","end":"2026-06-06T05:54:50.865759Z","steps":["trace[79917778] 'process raft request' (duration: 616.676283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.865918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.936645ms","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":"warn","ts":"2026-06-06T05:54:50.865983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.110711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-06T05:54:50.866023Z","caller":"traceutil/trace.go:171","msg":"trace[1931871675] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24774; }","duration":"468.082318ms","start":"2026-06-06T05:54:50.397871Z","end":"2026-06-06T05:54:50.865953Z","steps":["trace[1931871675] 'agreement among raft nodes before linearized reading' (duration: 467.950935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.865972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.963962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:50.86604Z","caller":"traceutil/trace.go:171","msg":"trace[1117117627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24774; }","duration":"184.211973ms","start":"2026-06-06T05:54:50.681815Z","end":"2026-06-06T05:54:50.866027Z","steps":["trace[1117117627] 'agreement among raft nodes before linearized reading' (duration: 184.034259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.866045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.620916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"warn","ts":"2026-06-06T05:54:50.866071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.397849Z","time spent":"468.208211ms","remote":"127.0.0.1:40996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-06T05:54:50.866106Z","caller":"traceutil/trace.go:171","msg":"trace[647433963] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:24774; }","duration":"418.713868ms","start":"2026-06-06T05:54:50.447375Z","end":"2026-06-06T05:54:50.866089Z","steps":["trace[647433963] 'agreement among raft nodes before linearized reading' (duration: 418.560234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.866048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.248775Z","time spent":"617.142263ms","remote":"127.0.0.1:52050","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-06-06T05:54:50.866135Z","caller":"traceutil/trace.go:171","msg":"trace[1336405545] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:24774; }","duration":"506.127816ms","start":"2026-06-06T05:54:50.359927Z","end":"2026-06-06T05:54:50.866055Z","steps":["trace[1336405545] 'agreement among raft nodes before linearized reading' (duration: 505.86977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.866189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.760033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:50.866269Z","caller":"traceutil/trace.go:171","msg":"trace[411311032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24774; }","duration":"419.905656ms","start":"2026-06-06T05:54:50.446344Z","end":"2026-06-06T05:54:50.866249Z","steps":["trace[411311032] 'agreement among raft nodes before linearized reading' (duration: 419.687861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:50.866228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.359911Z","time spent":"506.307391ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:54:50.866391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.446328Z","time spent":"420.05555ms","remote":"127.0.0.1:51742","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-06-06T05:54:50.866151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.447358Z","time spent":"418.78396ms","remote":"127.0.0.1:51924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"warn","ts":"2026-06-06T05:54:51.164796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.360824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:51.164973Z","caller":"traceutil/trace.go:171","msg":"trace[772987257] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"295.143697ms","start":"2026-06-06T05:54:50.86981Z","end":"2026-06-06T05:54:51.164954Z","steps":["trace[772987257] 'process raft request' (duration: 295.082285ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:51.165162Z","caller":"traceutil/trace.go:171","msg":"trace[85856107] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"295.331231ms","start":"2026-06-06T05:54:50.869637Z","end":"2026-06-06T05:54:51.164968Z","steps":["trace[85856107] 'process raft request' (duration: 62.705002ms)","trace[85856107] 'compare' (duration: 232.24944ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:51.799631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.473751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:51.799795Z","caller":"traceutil/trace.go:171","msg":"trace[1224982536] transaction","detail":"{read_only:false; response_revision:24777; number_of_response:1; }","duration":"848.252096ms","start":"2026-06-06T05:54:50.951502Z","end":"2026-06-06T05:54:51.799754Z","steps":["trace[1224982536] 'process raft request' (duration: 495.55869ms)","trace[1224982536] 'compare' (duration: 352.338638ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:51.799815Z","caller":"traceutil/trace.go:171","msg":"trace[985188896] transaction","detail":"{read_only:false; response_revision:24778; number_of_response:1; }","duration":"818.044908ms","start":"2026-06-06T05:54:50.981756Z","end":"2026-06-06T05:54:51.799801Z","steps":["trace[985188896] 'process raft request' (duration: 817.952526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:51.799873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.981739Z","time spent":"818.110109ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:51.799912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.95148Z","time spent":"848.365449ms","remote":"127.0.0.1:52050","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-06-06T05:54:51.800013Z","caller":"traceutil/trace.go:171","msg":"trace[1959298897] transaction","detail":"{read_only:false; response_revision:24779; number_of_response:1; }","duration":"648.912579ms","start":"2026-06-06T05:54:51.151094Z","end":"2026-06-06T05:54:51.800006Z","steps":["trace[1959298897] 'process raft request' (duration: 648.655643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:51.800052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.151069Z","time spent":"648.9616ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:54:51.800168Z","caller":"traceutil/trace.go:171","msg":"trace[854798432] linearizableReadLoop","detail":"{readStateIndex:25589; appliedIndex:25586; }","duration":"831.812769ms","start":"2026-06-06T05:54:50.968202Z","end":"2026-06-06T05:54:51.800015Z","steps":["trace[854798432] 'read index received' (duration: 194.025898ms)","trace[854798432] 'applied index is now lower than readState.Index' (duration: 637.782371ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:51.814986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.762919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-06T05:54:51.81504Z","caller":"traceutil/trace.go:171","msg":"trace[201196325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24779; }","duration":"846.862662ms","start":"2026-06-06T05:54:50.968161Z","end":"2026-06-06T05:54:51.815024Z","steps":["trace[201196325] 'agreement among raft nodes before linearized reading' (duration: 831.962343ms)","trace[201196325] 'range keys from in-memory index tree' (duration: 14.741445ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:51.815076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:50.968145Z","time spent":"846.924634ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-06T05:54:51.815301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.551362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-06T05:54:51.815304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.33816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/trunks/\" range_end:\"/registry/openstack.k-orc.cloud/trunks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:54:51.815337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.842247ms","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":"warn","ts":"2026-06-06T05:54:51.815376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.045249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:51.815371Z","caller":"traceutil/trace.go:171","msg":"trace[1451632825] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/trunks/; range_end:/registry/openstack.k-orc.cloud/trunks0; response_count:0; response_revision:24780; }","duration":"117.448842ms","start":"2026-06-06T05:54:51.697902Z","end":"2026-06-06T05:54:51.815351Z","steps":["trace[1451632825] 'agreement among raft nodes before linearized reading' (duration: 117.324689ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:51.815397Z","caller":"traceutil/trace.go:171","msg":"trace[1380982492] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24780; }","duration":"619.070449ms","start":"2026-06-06T05:54:51.19632Z","end":"2026-06-06T05:54:51.81539Z","steps":["trace[1380982492] 'agreement among raft nodes before linearized reading' (duration: 619.029658ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:51.815401Z","caller":"traceutil/trace.go:171","msg":"trace[518168777] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24780; }","duration":"541.96057ms","start":"2026-06-06T05:54:51.273422Z","end":"2026-06-06T05:54:51.815383Z","steps":["trace[518168777] 'agreement among raft nodes before linearized reading' (duration: 541.835597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:51.815417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.1963Z","time spent":"619.11152ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:54:51.815434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.273403Z","time spent":"542.024841ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-06T05:54:51.815335Z","caller":"traceutil/trace.go:171","msg":"trace[1062382042] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24780; }","duration":"692.642634ms","start":"2026-06-06T05:54:51.122685Z","end":"2026-06-06T05:54:51.815328Z","steps":["trace[1062382042] 'agreement among raft nodes before linearized reading' (duration: 692.539021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:51.815633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.122665Z","time spent":"692.959522ms","remote":"127.0.0.1:51970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-06T05:54:51.815636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.83598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:51.815754Z","caller":"traceutil/trace.go:171","msg":"trace[1593975634] transaction","detail":"{read_only:false; response_revision:24780; number_of_response:1; }","duration":"538.959678ms","start":"2026-06-06T05:54:51.276785Z","end":"2026-06-06T05:54:51.815744Z","steps":["trace[1593975634] 'process raft request' (duration: 538.133807ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:51.815792Z","caller":"traceutil/trace.go:171","msg":"trace[828510447] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:24780; }","duration":"521.042885ms","start":"2026-06-06T05:54:51.294716Z","end":"2026-06-06T05:54:51.815759Z","steps":["trace[828510447] 'agreement among raft nodes before linearized reading' (duration: 520.789719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:51.81585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.276763Z","time spent":"539.02334ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:51.815853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.294702Z","time spent":"521.138667ms","remote":"127.0.0.1:52194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:54:52.171439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.350264ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:52.171547Z","caller":"traceutil/trace.go:171","msg":"trace[1511190829] linearizableReadLoop","detail":"{readStateIndex:25594; appliedIndex:25593; }","duration":"349.727923ms","start":"2026-06-06T05:54:51.821801Z","end":"2026-06-06T05:54:52.171529Z","steps":["trace[1511190829] 'read index received' (duration: 78.079613ms)","trace[1511190829] 'applied index is now lower than readState.Index' (duration: 271.64701ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:52.171921Z","caller":"traceutil/trace.go:171","msg":"trace[1937177119] transaction","detail":"{read_only:false; response_revision:24781; number_of_response:1; }","duration":"351.453885ms","start":"2026-06-06T05:54:51.820441Z","end":"2026-06-06T05:54:52.171895Z","steps":["trace[1937177119] 'process raft request' (duration: 79.555119ms)","trace[1937177119] 'compare' (duration: 271.21514ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:52.172041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.820415Z","time spent":"351.559838ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:52.172083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.252757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"} {"level":"info","ts":"2026-06-06T05:54:52.172192Z","caller":"traceutil/trace.go:171","msg":"trace[1369443231] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24781; }","duration":"350.41008ms","start":"2026-06-06T05:54:51.82176Z","end":"2026-06-06T05:54:52.17217Z","steps":["trace[1369443231] 'agreement among raft nodes before linearized reading' (duration: 350.085342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.17225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.821747Z","time spent":"350.493551ms","remote":"127.0.0.1:51956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18391,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-06T05:54:52.729694Z","caller":"traceutil/trace.go:171","msg":"trace[490028518] transaction","detail":"{read_only:false; response_revision:24783; number_of_response:1; }","duration":"620.187155ms","start":"2026-06-06T05:54:52.109477Z","end":"2026-06-06T05:54:52.729664Z","steps":["trace[490028518] 'process raft request' (duration: 580.16095ms)","trace[490028518] 'compare' (duration: 39.852261ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:52.729858Z","caller":"traceutil/trace.go:171","msg":"trace[1702748550] linearizableReadLoop","detail":"{readStateIndex:25597; appliedIndex:25594; }","duration":"558.203761ms","start":"2026-06-06T05:54:52.171629Z","end":"2026-06-06T05:54:52.729833Z","steps":["trace[1702748550] 'read index received' (duration: 1.563517ms)","trace[1702748550] 'applied index is now lower than readState.Index' (duration: 556.639124ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:52.730046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.425633ms","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-06-06T05:54:52.730055Z","caller":"traceutil/trace.go:171","msg":"trace[1357453842] transaction","detail":"{read_only:false; response_revision:24784; number_of_response:1; }","duration":"619.940569ms","start":"2026-06-06T05:54:52.110073Z","end":"2026-06-06T05:54:52.730014Z","steps":["trace[1357453842] 'process raft request' (duration: 619.55452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.730124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.400263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:54:52.730126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.542092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-06T05:54:52.730138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.535088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:52.73022Z","caller":"traceutil/trace.go:171","msg":"trace[1959292372] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:24784; }","duration":"899.691646ms","start":"2026-06-06T05:54:51.830507Z","end":"2026-06-06T05:54:52.730198Z","steps":["trace[1959292372] 'agreement among raft nodes before linearized reading' (duration: 899.528402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.730142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:52.109458Z","time spent":"620.323039ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:52.730271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.830492Z","time spent":"899.767708ms","remote":"127.0.0.1:40014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:54:52.730274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:52.110059Z","time spent":"620.115934ms","remote":"127.0.0.1:52050","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-06-06T05:54:52.730238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.07935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:54:52.730314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.229607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-06T05:54:52.730395Z","caller":"traceutil/trace.go:171","msg":"trace[1688775092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24784; }","duration":"284.225964ms","start":"2026-06-06T05:54:52.446107Z","end":"2026-06-06T05:54:52.730333Z","steps":["trace[1688775092] 'agreement among raft nodes before linearized reading' (duration: 284.04085ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:52.730479Z","caller":"traceutil/trace.go:171","msg":"trace[183232203] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24784; }","duration":"576.422811ms","start":"2026-06-06T05:54:52.153998Z","end":"2026-06-06T05:54:52.730421Z","steps":["trace[183232203] 'agreement among raft nodes before linearized reading' (duration: 575.988511ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:52.730125Z","caller":"traceutil/trace.go:171","msg":"trace[168259317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24784; }","duration":"574.529105ms","start":"2026-06-06T05:54:52.155576Z","end":"2026-06-06T05:54:52.730105Z","steps":["trace[168259317] 'agreement among raft nodes before linearized reading' (duration: 574.269508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.730556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:52.153972Z","time spent":"576.548813ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-06T05:54:52.730271Z","caller":"traceutil/trace.go:171","msg":"trace[1550295815] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:24784; }","duration":"854.695031ms","start":"2026-06-06T05:54:51.875553Z","end":"2026-06-06T05:54:52.730248Z","steps":["trace[1550295815] 'agreement among raft nodes before linearized reading' (duration: 854.504616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.730627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.875542Z","time spent":"855.07465ms","remote":"127.0.0.1:52426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:54:52.730554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:52.155559Z","time spent":"574.982586ms","remote":"127.0.0.1:52050","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":"warn","ts":"2026-06-06T05:54:52.7306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.954565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274796"} {"level":"warn","ts":"2026-06-06T05:54:52.730059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.563219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:52.730713Z","caller":"traceutil/trace.go:171","msg":"trace[2031594928] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:24784; }","duration":"682.133649ms","start":"2026-06-06T05:54:52.048554Z","end":"2026-06-06T05:54:52.730687Z","steps":["trace[2031594928] 'agreement among raft nodes before linearized reading' (duration: 681.31709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.730772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:52.048522Z","time spent":"682.237952ms","remote":"127.0.0.1:52244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":32,"response size":274819,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "} {"level":"info","ts":"2026-06-06T05:54:52.730768Z","caller":"traceutil/trace.go:171","msg":"trace[1732776152] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:24784; }","duration":"763.333388ms","start":"2026-06-06T05:54:51.967412Z","end":"2026-06-06T05:54:52.730746Z","steps":["trace[1732776152] 'agreement among raft nodes before linearized reading' (duration: 762.58695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.731023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:51.967384Z","time spent":"763.597123ms","remote":"127.0.0.1:52096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-06-06T05:54:52.730166Z","caller":"traceutil/trace.go:171","msg":"trace[1837889274] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24784; }","duration":"506.492425ms","start":"2026-06-06T05:54:52.223663Z","end":"2026-06-06T05:54:52.730155Z","steps":["trace[1837889274] 'agreement among raft nodes before linearized reading' (duration: 506.431423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:52.73118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:52.223634Z","time spent":"507.534721ms","remote":"127.0.0.1:52244","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":"info","ts":"2026-06-06T05:54:53.008184Z","caller":"traceutil/trace.go:171","msg":"trace[367413793] transaction","detail":"{read_only:false; response_revision:24785; number_of_response:1; }","duration":"271.728253ms","start":"2026-06-06T05:54:52.736425Z","end":"2026-06-06T05:54:53.008153Z","steps":["trace[367413793] 'process raft request' (duration: 267.583033ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:53.008463Z","caller":"traceutil/trace.go:171","msg":"trace[1921824893] linearizableReadLoop","detail":"{readStateIndex:25599; appliedIndex:25597; }","duration":"269.95224ms","start":"2026-06-06T05:54:52.738497Z","end":"2026-06-06T05:54:53.008449Z","steps":["trace[1921824893] 'read index received' (duration: 265.527584ms)","trace[1921824893] 'applied index is now lower than readState.Index' (duration: 4.423806ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:53.008434Z","caller":"traceutil/trace.go:171","msg":"trace[1533066195] transaction","detail":"{read_only:false; response_revision:24786; number_of_response:1; }","duration":"271.580408ms","start":"2026-06-06T05:54:52.736821Z","end":"2026-06-06T05:54:53.008402Z","steps":["trace[1533066195] 'process raft request' (duration: 271.24154ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:53.008585Z","caller":"traceutil/trace.go:171","msg":"trace[1634507126] transaction","detail":"{read_only:false; response_revision:24787; number_of_response:1; }","duration":"137.62058ms","start":"2026-06-06T05:54:52.870956Z","end":"2026-06-06T05:54:53.008576Z","steps":["trace[1634507126] 'process raft request' (duration: 137.321111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.00889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.328059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-06T05:54:53.008958Z","caller":"traceutil/trace.go:171","msg":"trace[168640433] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24787; }","duration":"270.488633ms","start":"2026-06-06T05:54:52.738453Z","end":"2026-06-06T05:54:53.008941Z","steps":["trace[168640433] 'agreement among raft nodes before linearized reading' (duration: 270.231947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.00909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.095918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-06T05:54:53.00915Z","caller":"traceutil/trace.go:171","msg":"trace[830117651] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24787; }","duration":"157.224512ms","start":"2026-06-06T05:54:52.851907Z","end":"2026-06-06T05:54:53.009132Z","steps":["trace[830117651] 'agreement among raft nodes before linearized reading' (duration: 156.700819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.557274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.712699ms","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-06-06T05:54:53.557403Z","caller":"traceutil/trace.go:171","msg":"trace[439164374] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24788; }","duration":"348.858783ms","start":"2026-06-06T05:54:53.208524Z","end":"2026-06-06T05:54:53.557383Z","steps":["trace[439164374] 'range keys from in-memory index tree' (duration: 348.695289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.557447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.532103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:53.557514Z","caller":"traceutil/trace.go:171","msg":"trace[457408056] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24788; }","duration":"107.636045ms","start":"2026-06-06T05:54:53.449853Z","end":"2026-06-06T05:54:53.557489Z","steps":["trace[457408056] 'range keys from in-memory index tree' (duration: 107.285247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.557569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.933237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:54:53.557624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.304751ms","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-06-06T05:54:53.55771Z","caller":"traceutil/trace.go:171","msg":"trace[1066883099] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24788; }","duration":"387.435724ms","start":"2026-06-06T05:54:53.170258Z","end":"2026-06-06T05:54:53.557694Z","steps":["trace[1066883099] 'range keys from in-memory index tree' (duration: 387.104495ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:53.557644Z","caller":"traceutil/trace.go:171","msg":"trace[1877218249] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:24788; }","duration":"160.089492ms","start":"2026-06-06T05:54:53.397541Z","end":"2026-06-06T05:54:53.55763Z","steps":["trace[1877218249] 'count revisions from in-memory index tree' (duration: 159.825305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.557754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.170238Z","time spent":"387.506215ms","remote":"127.0.0.1:52050","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-06-06T05:54:53.557853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.327685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-06T05:54:53.557963Z","caller":"traceutil/trace.go:171","msg":"trace[487500253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24788; }","duration":"388.474639ms","start":"2026-06-06T05:54:53.169469Z","end":"2026-06-06T05:54:53.557943Z","steps":["trace[487500253] 'range keys from in-memory index tree' (duration: 387.74117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.558059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.169452Z","time spent":"388.588571ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-06T05:54:53.557384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.057227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-06-06T05:54:53.558282Z","caller":"traceutil/trace.go:171","msg":"trace[1247516900] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:24788; }","duration":"135.98176ms","start":"2026-06-06T05:54:53.422253Z","end":"2026-06-06T05:54:53.558235Z","steps":["trace[1247516900] 'range keys from in-memory index tree' (duration: 134.853722ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:53.863616Z","caller":"traceutil/trace.go:171","msg":"trace[1246030136] transaction","detail":"{read_only:false; response_revision:24789; number_of_response:1; }","duration":"301.344687ms","start":"2026-06-06T05:54:53.562234Z","end":"2026-06-06T05:54:53.863579Z","steps":["trace[1246030136] 'process raft request' (duration: 301.074741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:53.863879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.562212Z","time spent":"301.514962ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:54.321568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.812102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:54:54.321818Z","caller":"traceutil/trace.go:171","msg":"trace[748577939] transaction","detail":"{read_only:false; response_revision:24790; number_of_response:1; }","duration":"759.121377ms","start":"2026-06-06T05:54:53.562662Z","end":"2026-06-06T05:54:54.321784Z","steps":["trace[748577939] 'process raft request' (duration: 397.982707ms)","trace[748577939] 'compare' (duration: 360.537616ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:54:54.321883Z","caller":"traceutil/trace.go:171","msg":"trace[1713956787] transaction","detail":"{read_only:false; response_revision:24791; number_of_response:1; }","duration":"514.691912ms","start":"2026-06-06T05:54:53.807169Z","end":"2026-06-06T05:54:54.32186Z","steps":["trace[1713956787] 'process raft request' (duration: 514.505107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:54.321964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.807144Z","time spent":"514.782434ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:54:54.322297Z","caller":"traceutil/trace.go:171","msg":"trace[876928198] transaction","detail":"{read_only:false; response_revision:24792; number_of_response:1; }","duration":"513.074923ms","start":"2026-06-06T05:54:53.809026Z","end":"2026-06-06T05:54:54.322101Z","steps":["trace[876928198] 'process raft request' (duration: 512.777656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:54.322311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.562654Z","time spent":"759.238529ms","remote":"127.0.0.1:52050","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-06-06T05:54:54.32245Z","caller":"traceutil/trace.go:171","msg":"trace[1406827941] transaction","detail":"{read_only:false; response_revision:24793; number_of_response:1; }","duration":"501.72381ms","start":"2026-06-06T05:54:53.820705Z","end":"2026-06-06T05:54:54.322428Z","steps":["trace[1406827941] 'process raft request' (duration: 501.284529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:54.322567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.82068Z","time spent":"501.831023ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:54:54.322615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:53.809008Z","time spent":"513.351811ms","remote":"127.0.0.1:52050","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-06-06T05:54:54.322632Z","caller":"traceutil/trace.go:171","msg":"trace[744547823] transaction","detail":"{read_only:false; response_revision:24794; number_of_response:1; }","duration":"307.894686ms","start":"2026-06-06T05:54:54.01472Z","end":"2026-06-06T05:54:54.322615Z","steps":["trace[744547823] 'process raft request' (duration: 307.827944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:54.32272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:54:54.014683Z","time spent":"307.994338ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:54:54.322702Z","caller":"traceutil/trace.go:171","msg":"trace[976644673] linearizableReadLoop","detail":"{readStateIndex:25607; appliedIndex:25607; }","duration":"162.685133ms","start":"2026-06-06T05:54:54.159997Z","end":"2026-06-06T05:54:54.322682Z","steps":["trace[976644673] 'read index received' (duration: 162.675263ms)","trace[976644673] 'applied index is now lower than readState.Index' (duration: 8.28µs)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:54:54.322844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.842537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:54:54.322928Z","caller":"traceutil/trace.go:171","msg":"trace[13832774] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:24794; }","duration":"162.977031ms","start":"2026-06-06T05:54:54.159939Z","end":"2026-06-06T05:54:54.322916Z","steps":["trace[13832774] 'agreement among raft nodes before linearized reading' (duration: 162.823247ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:54:54.324289Z","caller":"traceutil/trace.go:171","msg":"trace[791895041] transaction","detail":"{read_only:false; response_revision:24795; number_of_response:1; }","duration":"144.824013ms","start":"2026-06-06T05:54:54.179453Z","end":"2026-06-06T05:54:54.324278Z","steps":["trace[791895041] 'process raft request' (duration: 144.617978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:54:54.324284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.557143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-06T05:54:54.324344Z","caller":"traceutil/trace.go:171","msg":"trace[931688017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24795; }","duration":"148.661575ms","start":"2026-06-06T05:54:54.175668Z","end":"2026-06-06T05:54:54.32433Z","steps":["trace[931688017] 'agreement among raft nodes before linearized reading' (duration: 148.486141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:03.661281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.556059ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:55:03.661356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.503065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:55:03.661403Z","caller":"traceutil/trace.go:171","msg":"trace[1887418517] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24876; }","duration":"451.687433ms","start":"2026-06-06T05:55:03.209697Z","end":"2026-06-06T05:55:03.661385Z","steps":["trace[1887418517] 'range keys from in-memory index tree' (duration: 451.121308ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:03.661455Z","caller":"traceutil/trace.go:171","msg":"trace[863613224] linearizableReadLoop","detail":"{readStateIndex:25692; appliedIndex:25691; }","duration":"472.832273ms","start":"2026-06-06T05:55:03.188607Z","end":"2026-06-06T05:55:03.66144Z","steps":["trace[863613224] 'read index received' (duration: 153.095303ms)","trace[863613224] 'applied index is now lower than readState.Index' (duration: 319.7354ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:03.661616Z","caller":"traceutil/trace.go:171","msg":"trace[1846607492] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"548.715643ms","start":"2026-06-06T05:55:03.112886Z","end":"2026-06-06T05:55:03.661602Z","steps":["trace[1846607492] 'process raft request' (duration: 228.89302ms)","trace[1846607492] 'compare' (duration: 319.191828ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:03.661684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.062318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-06T05:55:03.661707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:03.112871Z","time spent":"548.773344ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:03.661731Z","caller":"traceutil/trace.go:171","msg":"trace[1385800001] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24877; }","duration":"473.14008ms","start":"2026-06-06T05:55:03.188579Z","end":"2026-06-06T05:55:03.661719Z","steps":["trace[1385800001] 'agreement among raft nodes before linearized reading' (duration: 472.987157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:03.661754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:03.188564Z","time spent":"473.186171ms","remote":"127.0.0.1:51970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-06T05:55:03.66177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.626712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:03.661795Z","caller":"traceutil/trace.go:171","msg":"trace[487091048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24877; }","duration":"213.652822ms","start":"2026-06-06T05:55:03.448134Z","end":"2026-06-06T05:55:03.661787Z","steps":["trace[487091048] 'agreement among raft nodes before linearized reading' (duration: 213.600361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:03.661899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.183229ms","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-06-06T05:55:03.661921Z","caller":"traceutil/trace.go:171","msg":"trace[1653502626] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24877; }","duration":"198.24191ms","start":"2026-06-06T05:55:03.463673Z","end":"2026-06-06T05:55:03.661915Z","steps":["trace[1653502626] 'agreement among raft nodes before linearized reading' (duration: 198.210339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:04.051602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.890939ms","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-06-06T05:55:04.051697Z","caller":"traceutil/trace.go:171","msg":"trace[239149123] 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:24877; }","duration":"124.020391ms","start":"2026-06-06T05:55:03.927654Z","end":"2026-06-06T05:55:04.051674Z","steps":["trace[239149123] 'count revisions from in-memory index tree' (duration: 123.838577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:04.051598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.969748ms","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-06-06T05:55:04.051931Z","caller":"traceutil/trace.go:171","msg":"trace[1772674530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24877; }","duration":"138.341427ms","start":"2026-06-06T05:55:03.913552Z","end":"2026-06-06T05:55:04.051894Z","steps":["trace[1772674530] 'range keys from in-memory index tree' (duration: 137.774192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:04.775454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.190728ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:55:04.775523Z","caller":"traceutil/trace.go:171","msg":"trace[843729816] transaction","detail":"{read_only:false; response_revision:24879; number_of_response:1; }","duration":"420.232934ms","start":"2026-06-06T05:55:04.355278Z","end":"2026-06-06T05:55:04.775511Z","steps":["trace[843729816] 'process raft request' (duration: 214.926164ms)","trace[843729816] 'compare' (duration: 205.107166ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:04.775558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.35525Z","time spent":"420.291565ms","remote":"127.0.0.1:52050","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-06-06T05:55:05.584746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.216737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:55:05.585053Z","caller":"traceutil/trace.go:171","msg":"trace[1980565225] linearizableReadLoop","detail":"{readStateIndex:25697; appliedIndex:25693; }","duration":"1.219700934s","start":"2026-06-06T05:55:04.365335Z","end":"2026-06-06T05:55:05.585036Z","steps":["trace[1980565225] 'read index received' (duration: 204.963593ms)","trace[1980565225] 'applied index is now lower than readState.Index' (duration: 1.014736511s)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:05.585124Z","caller":"traceutil/trace.go:171","msg":"trace[980396096] transaction","detail":"{read_only:false; response_revision:24881; number_of_response:1; }","duration":"1.224058789s","start":"2026-06-06T05:55:04.361055Z","end":"2026-06-06T05:55:05.585114Z","steps":["trace[980396096] 'process raft request' (duration: 1.223788072s)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.585191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.361032Z","time spent":"1.2241152s","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:05.585213Z","caller":"traceutil/trace.go:171","msg":"trace[1668985366] transaction","detail":"{read_only:false; response_revision:24882; number_of_response:1; }","duration":"1.223777742s","start":"2026-06-06T05:55:04.361402Z","end":"2026-06-06T05:55:05.58518Z","steps":["trace[1668985366] 'process raft request' (duration: 1.223586188s)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.585381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220043752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-06T05:55:05.585372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.361392Z","time spent":"1.223887694s","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:05.58541Z","caller":"traceutil/trace.go:171","msg":"trace[1549367386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24882; }","duration":"1.220094892s","start":"2026-06-06T05:55:04.365305Z","end":"2026-06-06T05:55:05.5854Z","steps":["trace[1549367386] 'agreement among raft nodes before linearized reading' (duration: 1.21998253s)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.585438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.365295Z","time spent":"1.220137493s","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-06T05:55:05.585466Z","caller":"traceutil/trace.go:171","msg":"trace[927367144] transaction","detail":"{read_only:false; response_revision:24880; number_of_response:1; }","duration":"1.224037578s","start":"2026-06-06T05:55:04.361055Z","end":"2026-06-06T05:55:05.585093Z","steps":["trace[927367144] 'process raft request' (duration: 841.38295ms)","trace[927367144] 'compare' (duration: 381.834079ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:05.585567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.361031Z","time spent":"1.224478219s","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:05.586853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221453026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-06T05:55:05.586905Z","caller":"traceutil/trace.go:171","msg":"trace[2108461161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24886; }","duration":"1.221526308s","start":"2026-06-06T05:55:04.365366Z","end":"2026-06-06T05:55:05.586893Z","steps":["trace[2108461161] 'agreement among raft nodes before linearized reading' (duration: 1.221374034s)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.586933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.365361Z","time spent":"1.221566929s","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-06T05:55:05.587197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.067883ms","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-06-06T05:55:05.58722Z","caller":"traceutil/trace.go:171","msg":"trace[1394320151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24886; }","duration":"474.124074ms","start":"2026-06-06T05:55:05.113088Z","end":"2026-06-06T05:55:05.587212Z","steps":["trace[1394320151] 'agreement among raft nodes before linearized reading' (duration: 474.057573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.587239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.113067Z","time spent":"474.166536ms","remote":"127.0.0.1:52050","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-06-06T05:55:05.587239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.599633ms","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-06-06T05:55:05.587306Z","caller":"traceutil/trace.go:171","msg":"trace[891110545] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24886; }","duration":"471.710056ms","start":"2026-06-06T05:55:05.115579Z","end":"2026-06-06T05:55:05.587289Z","steps":["trace[891110545] 'agreement among raft nodes before linearized reading' (duration: 471.522792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.587342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.115548Z","time spent":"471.785458ms","remote":"127.0.0.1:52050","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-06-06T05:55:05.587359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.935408ms","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-06-06T05:55:05.587332Z","caller":"traceutil/trace.go:171","msg":"trace[2093925573] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"817.806632ms","start":"2026-06-06T05:55:04.769504Z","end":"2026-06-06T05:55:05.58731Z","steps":["trace[2093925573] 'process raft request' (duration: 817.150765ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:05.587379Z","caller":"traceutil/trace.go:171","msg":"trace[688401083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24886; }","duration":"531.996469ms","start":"2026-06-06T05:55:05.055375Z","end":"2026-06-06T05:55:05.587372Z","steps":["trace[688401083] 'agreement among raft nodes before linearized reading' (duration: 531.944348ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:05.58735Z","caller":"traceutil/trace.go:171","msg":"trace[368913608] transaction","detail":"{read_only:false; response_revision:24883; number_of_response:1; }","duration":"953.570977ms","start":"2026-06-06T05:55:04.63374Z","end":"2026-06-06T05:55:05.587311Z","steps":["trace[368913608] 'process raft request' (duration: 952.823418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.58743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.648795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:05.587452Z","caller":"traceutil/trace.go:171","msg":"trace[1620154724] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:24886; }","duration":"661.696537ms","start":"2026-06-06T05:55:04.925748Z","end":"2026-06-06T05:55:05.587445Z","steps":["trace[1620154724] 'agreement among raft nodes before linearized reading' (duration: 661.661466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.58747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.925734Z","time spent":"661.731187ms","remote":"127.0.0.1:35382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:55:05.587463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.769485Z","time spent":"817.906314ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:05.587541Z","caller":"traceutil/trace.go:171","msg":"trace[1659755102] transaction","detail":"{read_only:false; response_revision:24886; number_of_response:1; }","duration":"540.585087ms","start":"2026-06-06T05:55:05.046944Z","end":"2026-06-06T05:55:05.587528Z","steps":["trace[1659755102] 'process raft request' (duration: 539.765157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.587575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.15666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:55:05.587614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.908564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:55:05.587612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.046919Z","time spent":"540.650968ms","remote":"127.0.0.1:52050","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-06-06T05:55:05.587642Z","caller":"traceutil/trace.go:171","msg":"trace[1888935641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24886; }","duration":"139.937764ms","start":"2026-06-06T05:55:05.447696Z","end":"2026-06-06T05:55:05.587634Z","steps":["trace[1888935641] 'agreement among raft nodes before linearized reading' (duration: 139.881393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.587627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.633716Z","time spent":"953.71826ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:05.587648Z","caller":"traceutil/trace.go:171","msg":"trace[1184992596] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:24886; }","duration":"677.290813ms","start":"2026-06-06T05:55:04.910339Z","end":"2026-06-06T05:55:05.587629Z","steps":["trace[1184992596] 'agreement among raft nodes before linearized reading' (duration: 677.13606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.587398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.055363Z","time spent":"532.03095ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-06T05:55:05.58772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.910314Z","time spent":"677.390765ms","remote":"127.0.0.1:39920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-06-06T05:55:05.587916Z","caller":"traceutil/trace.go:171","msg":"trace[1438149168] transaction","detail":"{read_only:false; response_revision:24885; number_of_response:1; }","duration":"815.246989ms","start":"2026-06-06T05:55:04.772014Z","end":"2026-06-06T05:55:05.587261Z","steps":["trace[1438149168] 'process raft request' (duration: 814.671136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:05.588117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:04.771969Z","time spent":"816.107371ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:06.110952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.044406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:55:06.111164Z","caller":"traceutil/trace.go:171","msg":"trace[517194244] transaction","detail":"{read_only:false; response_revision:24888; number_of_response:1; }","duration":"519.728804ms","start":"2026-06-06T05:55:05.591402Z","end":"2026-06-06T05:55:06.111131Z","steps":["trace[517194244] 'process raft request' (duration: 304.407771ms)","trace[517194244] 'compare' (duration: 214.797501ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:06.111199Z","caller":"traceutil/trace.go:171","msg":"trace[561978900] linearizableReadLoop","detail":"{readStateIndex:25706; appliedIndex:25702; }","duration":"457.084833ms","start":"2026-06-06T05:55:05.654102Z","end":"2026-06-06T05:55:06.111187Z","steps":["trace[561978900] 'read index received' (duration: 241.686868ms)","trace[561978900] 'applied index is now lower than readState.Index' (duration: 215.397075ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:06.111318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.59139Z","time spent":"519.840387ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:06.111543Z","caller":"traceutil/trace.go:171","msg":"trace[1984482628] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"518.947715ms","start":"2026-06-06T05:55:05.592578Z","end":"2026-06-06T05:55:06.111526Z","steps":["trace[1984482628] 'process raft request' (duration: 518.468143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:06.111638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.592565Z","time spent":"519.025136ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:06.11183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.641667ms","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-06-06T05:55:06.111936Z","caller":"traceutil/trace.go:171","msg":"trace[1097114349] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:24891; }","duration":"457.856632ms","start":"2026-06-06T05:55:05.65405Z","end":"2026-06-06T05:55:06.111906Z","steps":["trace[1097114349] 'agreement among raft nodes before linearized reading' (duration: 457.541164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:06.112027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.654032Z","time spent":"457.975274ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:55:06.112118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.522924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-06T05:55:06.112169Z","caller":"traceutil/trace.go:171","msg":"trace[848560317] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24891; }","duration":"445.586666ms","start":"2026-06-06T05:55:05.666565Z","end":"2026-06-06T05:55:06.112152Z","steps":["trace[848560317] 'agreement among raft nodes before linearized reading' (duration: 445.405261ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:06.112461Z","caller":"traceutil/trace.go:171","msg":"trace[1520572971] transaction","detail":"{read_only:false; response_revision:24891; number_of_response:1; }","duration":"519.390085ms","start":"2026-06-06T05:55:05.59303Z","end":"2026-06-06T05:55:06.11242Z","steps":["trace[1520572971] 'process raft request' (duration: 518.115395ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:06.112506Z","caller":"traceutil/trace.go:171","msg":"trace[433638363] transaction","detail":"{read_only:false; response_revision:24890; number_of_response:1; }","duration":"519.654951ms","start":"2026-06-06T05:55:05.592809Z","end":"2026-06-06T05:55:06.112464Z","steps":["trace[433638363] 'process raft request' (duration: 518.301709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:06.11259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.666558Z","time spent":"445.641287ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-06T05:55:06.112648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.593005Z","time spent":"519.541969ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:06.112669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.592803Z","time spent":"519.777955ms","remote":"127.0.0.1:52050","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-06-06T05:55:06.113082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.490556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-06T05:55:06.113309Z","caller":"traceutil/trace.go:171","msg":"trace[2032693326] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:24891; }","duration":"358.723191ms","start":"2026-06-06T05:55:05.75452Z","end":"2026-06-06T05:55:06.113244Z","steps":["trace[2032693326] 'agreement among raft nodes before linearized reading' (duration: 357.894762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:06.113379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:05.754501Z","time spent":"358.866065ms","remote":"127.0.0.1:51794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-06-06T05:55:07.001947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.77906ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-06-06T05:55:07.002017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:06.115179Z","time spent":"886.836027ms","remote":"127.0.0.1:51794","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-06T05:55:07.016344Z","caller":"traceutil/trace.go:171","msg":"trace[724477495] linearizableReadLoop","detail":"{readStateIndex:25709; appliedIndex:25706; }","duration":"806.202492ms","start":"2026-06-06T05:55:06.210114Z","end":"2026-06-06T05:55:07.016317Z","steps":["trace[724477495] 'read index received' (duration: 227.035955ms)","trace[724477495] 'applied index is now lower than readState.Index' (duration: 579.165657ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:07.016387Z","caller":"traceutil/trace.go:171","msg":"trace[985830520] transaction","detail":"{read_only:false; response_revision:24892; number_of_response:1; }","duration":"898.853566ms","start":"2026-06-06T05:55:06.117506Z","end":"2026-06-06T05:55:07.01636Z","steps":["trace[985830520] 'process raft request' (duration: 898.59281ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:07.016412Z","caller":"traceutil/trace.go:171","msg":"trace[1498024210] transaction","detail":"{read_only:false; response_revision:24893; number_of_response:1; }","duration":"898.748354ms","start":"2026-06-06T05:55:06.117637Z","end":"2026-06-06T05:55:07.016385Z","steps":["trace[1498024210] 'process raft request' (duration: 898.629021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:07.016494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.356546ms","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":"warn","ts":"2026-06-06T05:55:07.016522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:06.117487Z","time spent":"898.966369ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:07.016533Z","caller":"traceutil/trace.go:171","msg":"trace[2049783705] 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:24893; }","duration":"806.412507ms","start":"2026-06-06T05:55:06.210108Z","end":"2026-06-06T05:55:07.01652Z","steps":["trace[2049783705] 'agreement among raft nodes before linearized reading' (duration: 806.326395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:07.016569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:06.210087Z","time spent":"806.471999ms","remote":"127.0.0.1:52998","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":"warn","ts":"2026-06-06T05:55:07.016623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:06.117617Z","time spent":"898.928448ms","remote":"127.0.0.1:52050","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-06-06T05:55:07.035471Z","caller":"traceutil/trace.go:171","msg":"trace[1592587265] transaction","detail":"{read_only:false; response_revision:24894; number_of_response:1; }","duration":"255.282746ms","start":"2026-06-06T05:55:06.780172Z","end":"2026-06-06T05:55:07.035455Z","steps":["trace[1592587265] 'process raft request' (duration: 255.143942ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:07.035622Z","caller":"traceutil/trace.go:171","msg":"trace[1880893902] transaction","detail":"{read_only:false; response_revision:24895; number_of_response:1; }","duration":"212.003252ms","start":"2026-06-06T05:55:06.823612Z","end":"2026-06-06T05:55:07.035615Z","steps":["trace[1880893902] 'process raft request' (duration: 211.806458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:07.035889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.963252ms","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-06-06T05:55:07.035923Z","caller":"traceutil/trace.go:171","msg":"trace[1499274339] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:24896; }","duration":"545.006533ms","start":"2026-06-06T05:55:06.490907Z","end":"2026-06-06T05:55:07.035913Z","steps":["trace[1499274339] 'agreement among raft nodes before linearized reading' (duration: 544.907331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:07.035944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:06.490858Z","time spent":"545.079705ms","remote":"127.0.0.1:52212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:55:07.03619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.198804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-06T05:55:07.036272Z","caller":"traceutil/trace.go:171","msg":"trace[1714703309] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:24896; }","duration":"583.312926ms","start":"2026-06-06T05:55:06.452936Z","end":"2026-06-06T05:55:07.036249Z","steps":["trace[1714703309] 'agreement among raft nodes before linearized reading' (duration: 583.181843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:07.036321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:06.45292Z","time spent":"583.387439ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-06T05:55:11.508358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.132992ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-06T05:55:11.508642Z","caller":"traceutil/trace.go:171","msg":"trace[1310797100] linearizableReadLoop","detail":"{readStateIndex:25745; appliedIndex:25744; }","duration":"460.601678ms","start":"2026-06-06T05:55:11.048024Z","end":"2026-06-06T05:55:11.508626Z","steps":["trace[1310797100] 'read index received' (duration: 86.212549ms)","trace[1310797100] 'applied index is now lower than readState.Index' (duration: 374.388019ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:11.509222Z","caller":"traceutil/trace.go:171","msg":"trace[1174062495] transaction","detail":"{read_only:false; response_revision:24928; number_of_response:1; }","duration":"454.435139ms","start":"2026-06-06T05:55:11.054774Z","end":"2026-06-06T05:55:11.509209Z","steps":["trace[1174062495] 'process raft request' (duration: 453.718241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:11.509344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.054739Z","time spent":"454.523072ms","remote":"127.0.0.1:52050","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-06-06T05:55:11.651616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.792921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:11.651749Z","caller":"traceutil/trace.go:171","msg":"trace[797511233] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:24928; }","duration":"166.989817ms","start":"2026-06-06T05:55:11.484726Z","end":"2026-06-06T05:55:11.651715Z","steps":["trace[797511233] 'agreement among raft nodes before linearized reading' (duration: 24.47835ms)","trace[797511233] 'count revisions from in-memory index tree' (duration: 142.304941ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:11.651789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.785369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:11.651864Z","caller":"traceutil/trace.go:171","msg":"trace[2038787654] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24928; }","duration":"153.910502ms","start":"2026-06-06T05:55:11.497932Z","end":"2026-06-06T05:55:11.651842Z","steps":["trace[2038787654] 'count revisions from in-memory index tree' (duration: 142.497036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:11.651868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.234361ms","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":"warn","ts":"2026-06-06T05:55:11.651879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.840612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-06T05:55:11.651951Z","caller":"traceutil/trace.go:171","msg":"trace[944229658] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24928; }","duration":"594.344214ms","start":"2026-06-06T05:55:11.05758Z","end":"2026-06-06T05:55:11.651924Z","steps":["trace[944229658] 'agreement among raft nodes before linearized reading' (duration: 451.612572ms)","trace[944229658] 'range keys from in-memory index tree' (duration: 142.486717ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:11.651959Z","caller":"traceutil/trace.go:171","msg":"trace[337828679] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24928; }","duration":"603.971735ms","start":"2026-06-06T05:55:11.047962Z","end":"2026-06-06T05:55:11.651933Z","steps":["trace[337828679] 'agreement among raft nodes before linearized reading' (duration: 461.09733ms)","trace[337828679] 'range keys from in-memory index tree' (duration: 142.65595ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:11.651995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.05757Z","time spent":"594.415096ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-06T05:55:11.652004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.047939Z","time spent":"604.055878ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-06T05:55:11.980375Z","caller":"traceutil/trace.go:171","msg":"trace[415352602] transaction","detail":"{read_only:false; response_revision:24930; number_of_response:1; }","duration":"337.92615ms","start":"2026-06-06T05:55:11.642419Z","end":"2026-06-06T05:55:11.980345Z","steps":["trace[415352602] 'process raft request' (duration: 310.99584ms)","trace[415352602] 'compare' (duration: 26.719925ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:11.980552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.642393Z","time spent":"338.068903ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:11.980793Z","caller":"traceutil/trace.go:171","msg":"trace[102605905] transaction","detail":"{read_only:false; response_revision:24931; number_of_response:1; }","duration":"321.059524ms","start":"2026-06-06T05:55:11.659692Z","end":"2026-06-06T05:55:11.980751Z","steps":["trace[102605905] 'process raft request' (duration: 320.602333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:11.981021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.659674Z","time spent":"321.227347ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:11.981032Z","caller":"traceutil/trace.go:171","msg":"trace[1779932213] transaction","detail":"{read_only:false; response_revision:24932; number_of_response:1; }","duration":"317.761402ms","start":"2026-06-06T05:55:11.66324Z","end":"2026-06-06T05:55:11.981001Z","steps":["trace[1779932213] 'process raft request' (duration: 317.373663ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:11.981115Z","caller":"traceutil/trace.go:171","msg":"trace[7596665] transaction","detail":"{read_only:false; response_revision:24933; number_of_response:1; }","duration":"317.822954ms","start":"2026-06-06T05:55:11.663264Z","end":"2026-06-06T05:55:11.981087Z","steps":["trace[7596665] 'process raft request' (duration: 317.603558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:11.981198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.66322Z","time spent":"317.886735ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:11.981271Z","caller":"traceutil/trace.go:171","msg":"trace[907834829] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"313.292805ms","start":"2026-06-06T05:55:11.66796Z","end":"2026-06-06T05:55:11.981252Z","steps":["trace[907834829] 'process raft request' (duration: 313.101731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:11.981307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.663248Z","time spent":"317.955967ms","remote":"127.0.0.1:52050","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-06-06T05:55:11.981361Z","caller":"traceutil/trace.go:171","msg":"trace[1886775840] linearizableReadLoop","detail":"{readStateIndex:25754; appliedIndex:25747; }","duration":"287.287618ms","start":"2026-06-06T05:55:11.694053Z","end":"2026-06-06T05:55:11.981341Z","steps":["trace[1886775840] 'read index received' (duration: 18.182008ms)","trace[1886775840] 'applied index is now lower than readState.Index' (duration: 269.10442ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:55:11.981379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.667951Z","time spent":"313.377157ms","remote":"127.0.0.1:52050","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-06-06T05:55:11.981129Z","caller":"traceutil/trace.go:171","msg":"trace[910072061] transaction","detail":"{read_only:false; response_revision:24934; number_of_response:1; }","duration":"317.786183ms","start":"2026-06-06T05:55:11.663322Z","end":"2026-06-06T05:55:11.981108Z","steps":["trace[910072061] 'process raft request' (duration: 317.67934ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:11.981558Z","caller":"traceutil/trace.go:171","msg":"trace[1423716382] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"313.48365ms","start":"2026-06-06T05:55:11.668059Z","end":"2026-06-06T05:55:11.981543Z","steps":["trace[1423716382] 'process raft request' (duration: 313.133172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:11.98158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.663301Z","time spent":"318.242084ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:11.981632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:11.66804Z","time spent":"313.556292ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:11.981672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.606985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-06T05:55:11.981724Z","caller":"traceutil/trace.go:171","msg":"trace[1147762076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24936; }","duration":"287.687787ms","start":"2026-06-06T05:55:11.694022Z","end":"2026-06-06T05:55:11.981709Z","steps":["trace[1147762076] 'agreement among raft nodes before linearized reading' (duration: 287.498653ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:12.198175Z","caller":"traceutil/trace.go:171","msg":"trace[831117191] transaction","detail":"{read_only:false; response_revision:24938; number_of_response:1; }","duration":"155.47369ms","start":"2026-06-06T05:55:12.042661Z","end":"2026-06-06T05:55:12.198134Z","steps":["trace[831117191] 'process raft request' (duration: 155.235334ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:13.842946Z","caller":"traceutil/trace.go:171","msg":"trace[7401196] transaction","detail":"{read_only:false; response_revision:24944; number_of_response:1; }","duration":"329.323352ms","start":"2026-06-06T05:55:13.513607Z","end":"2026-06-06T05:55:13.84293Z","steps":["trace[7401196] 'process raft request' (duration: 329.148258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:13.843039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:13.513587Z","time spent":"329.400644ms","remote":"127.0.0.1:52050","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-06-06T05:55:13.843036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.715133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:13.842922Z","caller":"traceutil/trace.go:171","msg":"trace[1064290891] linearizableReadLoop","detail":"{readStateIndex:25762; appliedIndex:25761; }","duration":"327.5932ms","start":"2026-06-06T05:55:13.515305Z","end":"2026-06-06T05:55:13.842898Z","steps":["trace[1064290891] 'read index received' (duration: 327.457897ms)","trace[1064290891] 'applied index is now lower than readState.Index' (duration: 134.163µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:13.843099Z","caller":"traceutil/trace.go:171","msg":"trace[610949344] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:24944; }","duration":"327.812226ms","start":"2026-06-06T05:55:13.515275Z","end":"2026-06-06T05:55:13.843087Z","steps":["trace[610949344] 'agreement among raft nodes before linearized reading' (duration: 327.702613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:13.843148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:13.515267Z","time spent":"327.867047ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true "} {"level":"info","ts":"2026-06-06T05:55:13.929683Z","caller":"traceutil/trace.go:171","msg":"trace[1118998512] transaction","detail":"{read_only:false; response_revision:24945; number_of_response:1; }","duration":"209.967564ms","start":"2026-06-06T05:55:13.719687Z","end":"2026-06-06T05:55:13.929655Z","steps":["trace[1118998512] 'process raft request' (duration: 202.088643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:13.929733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.155251ms","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-06-06T05:55:13.929799Z","caller":"traceutil/trace.go:171","msg":"trace[122511983] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24945; }","duration":"184.264944ms","start":"2026-06-06T05:55:13.745516Z","end":"2026-06-06T05:55:13.929781Z","steps":["trace[122511983] 'agreement among raft nodes before linearized reading' (duration: 184.156201ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:16.039837Z","caller":"traceutil/trace.go:171","msg":"trace[1425198656] transaction","detail":"{read_only:false; response_revision:24968; number_of_response:1; }","duration":"140.351985ms","start":"2026-06-06T05:55:15.899468Z","end":"2026-06-06T05:55:16.03982Z","steps":["trace[1425198656] 'process raft request' (duration: 140.238562ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:16.039953Z","caller":"traceutil/trace.go:171","msg":"trace[1587621220] transaction","detail":"{read_only:false; response_revision:24967; number_of_response:1; }","duration":"191.847967ms","start":"2026-06-06T05:55:15.848097Z","end":"2026-06-06T05:55:16.039945Z","steps":["trace[1587621220] 'process raft request' (duration: 179.474439ms)","trace[1587621220] 'compare' (duration: 11.972218ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:16.040019Z","caller":"traceutil/trace.go:171","msg":"trace[2041959584] transaction","detail":"{read_only:false; response_revision:24969; number_of_response:1; }","duration":"106.012246ms","start":"2026-06-06T05:55:15.933999Z","end":"2026-06-06T05:55:16.040011Z","steps":["trace[2041959584] 'process raft request' (duration: 105.763701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.318347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.89121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T05:55:24.318613Z","caller":"traceutil/trace.go:171","msg":"trace[1211537102] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"246.599076ms","start":"2026-06-06T05:55:24.071997Z","end":"2026-06-06T05:55:24.318596Z","steps":["trace[1211537102] 'process raft request' (duration: 246.528425ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.318605Z","caller":"traceutil/trace.go:171","msg":"trace[1736786884] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"247.893118ms","start":"2026-06-06T05:55:24.070682Z","end":"2026-06-06T05:55:24.318575Z","steps":["trace[1736786884] 'process raft request' (duration: 137.67922ms)","trace[1736786884] 'compare' (duration: 109.48138ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:24.318605Z","caller":"traceutil/trace.go:171","msg":"trace[140729449] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"246.600287ms","start":"2026-06-06T05:55:24.071984Z","end":"2026-06-06T05:55:24.318584Z","steps":["trace[140729449] 'process raft request' (duration: 246.457004ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.318754Z","caller":"traceutil/trace.go:171","msg":"trace[629450677] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"245.921681ms","start":"2026-06-06T05:55:24.072823Z","end":"2026-06-06T05:55:24.318745Z","steps":["trace[629450677] 'process raft request' (duration: 245.825039ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.318754Z","caller":"traceutil/trace.go:171","msg":"trace[943427203] linearizableReadLoop","detail":"{readStateIndex:25853; appliedIndex:25846; }","duration":"239.67771ms","start":"2026-06-06T05:55:24.079065Z","end":"2026-06-06T05:55:24.318742Z","steps":["trace[943427203] 'read index received' (duration: 31.5065ms)","trace[943427203] 'applied index is now lower than readState.Index' (duration: 208.17038ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:24.318822Z","caller":"traceutil/trace.go:171","msg":"trace[766596310] transaction","detail":"{read_only:false; response_revision:25033; number_of_response:1; }","duration":"245.424438ms","start":"2026-06-06T05:55:24.07339Z","end":"2026-06-06T05:55:24.318815Z","steps":["trace[766596310] 'process raft request' (duration: 245.316325ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.318837Z","caller":"traceutil/trace.go:171","msg":"trace[256599766] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"246.824982ms","start":"2026-06-06T05:55:24.072Z","end":"2026-06-06T05:55:24.318825Z","steps":["trace[256599766] 'process raft request' (duration: 246.563006ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.318982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.037718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-06T05:55:24.319037Z","caller":"traceutil/trace.go:171","msg":"trace[1196762793] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25033; }","duration":"235.1198ms","start":"2026-06-06T05:55:24.083901Z","end":"2026-06-06T05:55:24.319021Z","steps":["trace[1196762793] 'agreement among raft nodes before linearized reading' (duration: 234.969136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.319047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.714319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-06T05:55:24.319075Z","caller":"traceutil/trace.go:171","msg":"trace[1849709787] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25033; }","duration":"202.78382ms","start":"2026-06-06T05:55:24.116284Z","end":"2026-06-06T05:55:24.319067Z","steps":["trace[1849709787] 'agreement among raft nodes before linearized reading' (duration: 202.700948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.31911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.40506ms","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-06-06T05:55:24.319163Z","caller":"traceutil/trace.go:171","msg":"trace[542964676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25033; }","duration":"197.532643ms","start":"2026-06-06T05:55:24.121622Z","end":"2026-06-06T05:55:24.319155Z","steps":["trace[542964676] 'agreement among raft nodes before linearized reading' (duration: 197.326148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.319165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.084299ms","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-06-06T05:55:24.319261Z","caller":"traceutil/trace.go:171","msg":"trace[309536171] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25033; }","duration":"240.188642ms","start":"2026-06-06T05:55:24.079055Z","end":"2026-06-06T05:55:24.319244Z","steps":["trace[309536171] 'agreement among raft nodes before linearized reading' (duration: 239.971517ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.532512Z","caller":"traceutil/trace.go:171","msg":"trace[1044268912] transaction","detail":"{read_only:false; response_revision:25035; number_of_response:1; }","duration":"209.194665ms","start":"2026-06-06T05:55:24.323294Z","end":"2026-06-06T05:55:24.532489Z","steps":["trace[1044268912] 'process raft request' (duration: 208.99974ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.533006Z","caller":"traceutil/trace.go:171","msg":"trace[439221147] transaction","detail":"{read_only:false; response_revision:25036; number_of_response:1; }","duration":"209.342198ms","start":"2026-06-06T05:55:24.323622Z","end":"2026-06-06T05:55:24.532965Z","steps":["trace[439221147] 'process raft request' (duration: 208.822826ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.533097Z","caller":"traceutil/trace.go:171","msg":"trace[1629135612] transaction","detail":"{read_only:false; response_revision:25037; number_of_response:1; }","duration":"208.749264ms","start":"2026-06-06T05:55:24.324333Z","end":"2026-06-06T05:55:24.533082Z","steps":["trace[1629135612] 'process raft request' (duration: 208.512939ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.53314Z","caller":"traceutil/trace.go:171","msg":"trace[1540712790] transaction","detail":"{read_only:false; response_revision:25038; number_of_response:1; }","duration":"208.732094ms","start":"2026-06-06T05:55:24.324376Z","end":"2026-06-06T05:55:24.533108Z","steps":["trace[1540712790] 'process raft request' (duration: 208.638312ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.533288Z","caller":"traceutil/trace.go:171","msg":"trace[338920679] linearizableReadLoop","detail":"{readStateIndex:25855; appliedIndex:25854; }","duration":"209.832601ms","start":"2026-06-06T05:55:24.323433Z","end":"2026-06-06T05:55:24.533265Z","steps":["trace[338920679] 'read index received' (duration: 77.51032ms)","trace[338920679] 'applied index is now lower than readState.Index' (duration: 132.321101ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:24.533333Z","caller":"traceutil/trace.go:171","msg":"trace[478147931] transaction","detail":"{read_only:false; response_revision:25039; number_of_response:1; }","duration":"208.898478ms","start":"2026-06-06T05:55:24.324423Z","end":"2026-06-06T05:55:24.533321Z","steps":["trace[478147931] 'process raft request' (duration: 208.641862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.533503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.051226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"} {"level":"info","ts":"2026-06-06T05:55:24.533545Z","caller":"traceutil/trace.go:171","msg":"trace[837420976] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25039; }","duration":"210.102897ms","start":"2026-06-06T05:55:24.32343Z","end":"2026-06-06T05:55:24.533533Z","steps":["trace[837420976] 'agreement among raft nodes before linearized reading' (duration: 209.949983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.572887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.399123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:24.57295Z","caller":"traceutil/trace.go:171","msg":"trace[1651718462] transaction","detail":"{read_only:false; response_revision:25040; number_of_response:1; }","duration":"172.518881ms","start":"2026-06-06T05:55:24.400396Z","end":"2026-06-06T05:55:24.572915Z","steps":["trace[1651718462] 'process raft request' (duration: 172.232594ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.573054Z","caller":"traceutil/trace.go:171","msg":"trace[992796521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25040; }","duration":"127.585348ms","start":"2026-06-06T05:55:24.445425Z","end":"2026-06-06T05:55:24.573011Z","steps":["trace[992796521] 'agreement among raft nodes before linearized reading' (duration: 127.379243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.803683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.354776ms","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-06-06T05:55:24.803788Z","caller":"traceutil/trace.go:171","msg":"trace[1700611772] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25040; }","duration":"133.471148ms","start":"2026-06-06T05:55:24.670279Z","end":"2026-06-06T05:55:24.80375Z","steps":["trace[1700611772] 'range keys from in-memory index tree' (duration: 133.301034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:24.803816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.803913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-06T05:55:24.80384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.309987ms","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-06-06T05:55:24.803921Z","caller":"traceutil/trace.go:171","msg":"trace[366676970] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:25040; }","duration":"120.985267ms","start":"2026-06-06T05:55:24.682906Z","end":"2026-06-06T05:55:24.803891Z","steps":["trace[366676970] 'count revisions from in-memory index tree' (duration: 120.729102ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:24.803943Z","caller":"traceutil/trace.go:171","msg":"trace[1628865277] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25040; }","duration":"158.454321ms","start":"2026-06-06T05:55:24.645458Z","end":"2026-06-06T05:55:24.803912Z","steps":["trace[1628865277] 'count revisions from in-memory index tree' (duration: 158.240826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:32.692155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.375149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-06T05:55:32.692238Z","caller":"traceutil/trace.go:171","msg":"trace[459254805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25094; }","duration":"124.494252ms","start":"2026-06-06T05:55:32.567726Z","end":"2026-06-06T05:55:32.69222Z","steps":["trace[459254805] 'range keys from in-memory index tree' (duration: 124.159934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:32.692241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.883598ms","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-06-06T05:55:32.692304Z","caller":"traceutil/trace.go:171","msg":"trace[1865729930] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25094; }","duration":"128.981101ms","start":"2026-06-06T05:55:32.563308Z","end":"2026-06-06T05:55:32.692289Z","steps":["trace[1865729930] 'range keys from in-memory index tree' (duration: 128.775696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:32.692318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.644975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-06T05:55:32.692304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.053705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-06T05:55:32.692398Z","caller":"traceutil/trace.go:171","msg":"trace[2140467883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25094; }","duration":"124.743278ms","start":"2026-06-06T05:55:32.567636Z","end":"2026-06-06T05:55:32.69238Z","steps":["trace[2140467883] 'range keys from in-memory index tree' (duration: 124.507102ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:32.692447Z","caller":"traceutil/trace.go:171","msg":"trace[247671043] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25094; }","duration":"120.26147ms","start":"2026-06-06T05:55:32.572158Z","end":"2026-06-06T05:55:32.692419Z","steps":["trace[247671043] 'range keys from in-memory index tree' (duration: 119.903102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:32.6925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.881378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-06T05:55:32.69257Z","caller":"traceutil/trace.go:171","msg":"trace[1807987666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25094; }","duration":"128.995501ms","start":"2026-06-06T05:55:32.563559Z","end":"2026-06-06T05:55:32.692555Z","steps":["trace[1807987666] 'range keys from in-memory index tree' (duration: 128.721064ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:45.126481Z","caller":"traceutil/trace.go:171","msg":"trace[519190516] transaction","detail":"{read_only:false; response_revision:25181; number_of_response:1; }","duration":"345.163333ms","start":"2026-06-06T05:55:44.781296Z","end":"2026-06-06T05:55:45.126459Z","steps":["trace[519190516] 'process raft request' (duration: 345.01486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:45.126606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:44.781285Z","time spent":"345.259006ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T05:55:45.126732Z","caller":"traceutil/trace.go:171","msg":"trace[1621423577] linearizableReadLoop","detail":"{readStateIndex:26006; appliedIndex:26003; }","duration":"343.211087ms","start":"2026-06-06T05:55:44.783501Z","end":"2026-06-06T05:55:45.126712Z","steps":["trace[1621423577] 'read index received' (duration: 72.776415ms)","trace[1621423577] 'applied index is now lower than readState.Index' (duration: 270.433682ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:45.126798Z","caller":"traceutil/trace.go:171","msg":"trace[150279647] transaction","detail":"{read_only:false; response_revision:25183; number_of_response:1; }","duration":"342.800486ms","start":"2026-06-06T05:55:44.783984Z","end":"2026-06-06T05:55:45.126785Z","steps":["trace[150279647] 'process raft request' (duration: 342.639112ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:45.126801Z","caller":"traceutil/trace.go:171","msg":"trace[1360717596] transaction","detail":"{read_only:false; response_revision:25182; number_of_response:1; }","duration":"344.993299ms","start":"2026-06-06T05:55:44.781766Z","end":"2026-06-06T05:55:45.126759Z","steps":["trace[1360717596] 'process raft request' (duration: 344.664781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:45.126845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:44.783963Z","time spent":"342.856918ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:45.126977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:44.781748Z","time spent":"345.140003ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:55:45.127018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.488904ms","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-06-06T05:55:45.127098Z","caller":"traceutil/trace.go:171","msg":"trace[1531219838] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25183; }","duration":"343.593897ms","start":"2026-06-06T05:55:44.783477Z","end":"2026-06-06T05:55:45.127071Z","steps":["trace[1531219838] 'agreement among raft nodes before linearized reading' (duration: 343.381562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:45.127153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:44.783467Z","time spent":"343.670788ms","remote":"127.0.0.1:52050","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-06-06T05:55:45.127023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.118439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:45.127538Z","caller":"traceutil/trace.go:171","msg":"trace[1472015217] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:25183; }","duration":"310.661412ms","start":"2026-06-06T05:55:44.816856Z","end":"2026-06-06T05:55:45.127517Z","steps":["trace[1472015217] 'agreement among raft nodes before linearized reading' (duration: 310.101199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:45.127655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:55:44.816839Z","time spent":"310.793155ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true "} {"level":"info","ts":"2026-06-06T05:55:46.563411Z","caller":"traceutil/trace.go:171","msg":"trace[1766007543] linearizableReadLoop","detail":"{readStateIndex:26017; appliedIndex:26012; }","duration":"118.633781ms","start":"2026-06-06T05:55:46.444757Z","end":"2026-06-06T05:55:46.563391Z","steps":["trace[1766007543] 'read index received' (duration: 118.366604ms)","trace[1766007543] 'applied index is now lower than readState.Index' (duration: 266.467µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:55:46.56364Z","caller":"traceutil/trace.go:171","msg":"trace[535518124] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"157.885827ms","start":"2026-06-06T05:55:46.405746Z","end":"2026-06-06T05:55:46.563631Z","steps":["trace[535518124] 'process raft request' (duration: 157.425066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:55:46.564175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.397079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T05:55:46.564209Z","caller":"traceutil/trace.go:171","msg":"trace[1909235726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25192; }","duration":"119.479342ms","start":"2026-06-06T05:55:46.444721Z","end":"2026-06-06T05:55:46.564201Z","steps":["trace[1909235726] 'agreement among raft nodes before linearized reading' (duration: 119.40029ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:46.564328Z","caller":"traceutil/trace.go:171","msg":"trace[1099393395] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"158.320498ms","start":"2026-06-06T05:55:46.406Z","end":"2026-06-06T05:55:46.564321Z","steps":["trace[1099393395] 'process raft request' (duration: 157.281953ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:46.564388Z","caller":"traceutil/trace.go:171","msg":"trace[594684230] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"155.246703ms","start":"2026-06-06T05:55:46.409135Z","end":"2026-06-06T05:55:46.564381Z","steps":["trace[594684230] 'process raft request' (duration: 154.178688ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:46.56447Z","caller":"traceutil/trace.go:171","msg":"trace[1621194264] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"155.168512ms","start":"2026-06-06T05:55:46.409272Z","end":"2026-06-06T05:55:46.56444Z","steps":["trace[1621194264] 'process raft request' (duration: 154.067705ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:55:46.564525Z","caller":"traceutil/trace.go:171","msg":"trace[1674484175] transaction","detail":"{read_only:false; response_revision:25192; number_of_response:1; }","duration":"154.909315ms","start":"2026-06-06T05:55:46.40961Z","end":"2026-06-06T05:55:46.564519Z","steps":["trace[1674484175] 'process raft request' (duration: 153.755078ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:56:42.816571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22959} {"level":"info","ts":"2026-06-06T05:56:42.945234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22959,"took":"125.27136ms","hash":1479934259,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":33316864,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-06T05:56:42.945311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1479934259,"revision":22959,"compact-revision":19988} {"level":"info","ts":"2026-06-06T06:00:39.632472Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006ea4.wal"} {"level":"info","ts":"2026-06-06T06:01:42.823255Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25615} {"level":"info","ts":"2026-06-06T06:01:42.954412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25615,"took":"127.156406ms","hash":205054346,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":31006720,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-06T06:01:42.95447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":205054346,"revision":25615,"compact-revision":22959} {"level":"info","ts":"2026-06-06T06:04:06.578787Z","caller":"traceutil/trace.go:171","msg":"trace[1963086506] transaction","detail":"{read_only:false; response_revision:29046; number_of_response:1; }","duration":"173.883273ms","start":"2026-06-06T06:04:06.404885Z","end":"2026-06-06T06:04:06.578768Z","steps":["trace[1963086506] 'process raft request' (duration: 173.73378ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T06:04:06.578761Z","caller":"traceutil/trace.go:171","msg":"trace[409653545] transaction","detail":"{read_only:false; response_revision:29045; number_of_response:1; }","duration":"173.910123ms","start":"2026-06-06T06:04:06.404821Z","end":"2026-06-06T06:04:06.578731Z","steps":["trace[409653545] 'process raft request' (duration: 82.324785ms)","trace[409653545] 'compare' (duration: 91.287161ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T06:04:06.57929Z","caller":"traceutil/trace.go:171","msg":"trace[1866907210] transaction","detail":"{read_only:false; response_revision:29047; number_of_response:1; }","duration":"174.295563ms","start":"2026-06-06T06:04:06.404959Z","end":"2026-06-06T06:04:06.579254Z","steps":["trace[1866907210] 'process raft request' (duration: 173.74142ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T06:04:06.579632Z","caller":"traceutil/trace.go:171","msg":"trace[1790279904] transaction","detail":"{read_only:false; response_revision:29048; number_of_response:1; }","duration":"172.273424ms","start":"2026-06-06T06:04:06.407278Z","end":"2026-06-06T06:04:06.579551Z","steps":["trace[1790279904] 'process raft request' (duration: 171.6901ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T06:04:10.089083Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-06T06:04:10.09472Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-06T06:04:10.094841Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-06T06:06:42.829935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27998} {"level":"info","ts":"2026-06-06T06:06:42.964254Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27998,"took":"130.523088ms","hash":533728000,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":30306304,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-06T06:06:42.964341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":533728000,"revision":27998,"compact-revision":25615} {"level":"info","ts":"2026-06-06T06:06:52.939027Z","caller":"traceutil/trace.go:171","msg":"trace[1603179985] transaction","detail":"{read_only:false; response_revision:30323; number_of_response:1; }","duration":"134.889692ms","start":"2026-06-06T06:06:52.804108Z","end":"2026-06-06T06:06:52.938998Z","steps":["trace[1603179985] 'process raft request' (duration: 119.293326ms)","trace[1603179985] 'compare' (duration: 15.482083ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T06:11:13.86279Z","caller":"traceutil/trace.go:171","msg":"trace[1461108174] transaction","detail":"{read_only:false; response_revision:32810; number_of_response:1; }","duration":"122.77883ms","start":"2026-06-06T06:11:13.73998Z","end":"2026-06-06T06:11:13.862759Z","steps":["trace[1461108174] 'process raft request' (duration: 34.944032ms)","trace[1461108174] 'compare' (duration: 87.605242ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T06:11:13.873445Z","caller":"traceutil/trace.go:171","msg":"trace[930431745] linearizableReadLoop","detail":"{readStateIndex:33839; appliedIndex:33837; }","duration":"131.631534ms","start":"2026-06-06T06:11:13.741787Z","end":"2026-06-06T06:11:13.873419Z","steps":["trace[930431745] 'read index received' (duration: 33.080348ms)","trace[930431745] 'applied index is now lower than readState.Index' (duration: 98.549666ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T06:11:13.873555Z","caller":"traceutil/trace.go:171","msg":"trace[677877065] transaction","detail":"{read_only:false; response_revision:32811; number_of_response:1; }","duration":"132.886064ms","start":"2026-06-06T06:11:13.740656Z","end":"2026-06-06T06:11:13.873542Z","steps":["trace[677877065] 'process raft request' (duration: 132.628198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T06:11:13.873759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.951311ms","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-06-06T06:11:13.873837Z","caller":"traceutil/trace.go:171","msg":"trace[927905839] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:32811; }","duration":"132.064434ms","start":"2026-06-06T06:11:13.741754Z","end":"2026-06-06T06:11:13.873818Z","steps":["trace[927905839] 'agreement among raft nodes before linearized reading' (duration: 131.809128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T06:11:13.911418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.512435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-06T06:11:13.911466Z","caller":"traceutil/trace.go:171","msg":"trace[1782028447] transaction","detail":"{read_only:false; response_revision:32812; number_of_response:1; }","duration":"122.916714ms","start":"2026-06-06T06:11:13.788514Z","end":"2026-06-06T06:11:13.911431Z","steps":["trace[1782028447] 'process raft request' (duration: 122.468633ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T06:11:13.911528Z","caller":"traceutil/trace.go:171","msg":"trace[1512934777] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:32812; }","duration":"122.654828ms","start":"2026-06-06T06:11:13.788839Z","end":"2026-06-06T06:11:13.911494Z","steps":["trace[1512934777] 'agreement among raft nodes before linearized reading' (duration: 122.34007ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T06:11:42.841169Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30250} {"level":"info","ts":"2026-06-06T06:11:42.951584Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30250,"took":"107.357699ms","hash":1119433125,"current-db-size-bytes":58880000,"current-db-size":"59 MB","current-db-size-in-use-bytes":35377152,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-06T06:11:42.951645Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1119433125,"revision":30250,"compact-revision":27998} {"level":"info","ts":"2026-06-06T06:16:42.847673Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33134} {"level":"info","ts":"2026-06-06T06:16:43.016927Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33134,"took":"164.242171ms","hash":3977991745,"current-db-size-bytes":59920384,"current-db-size":"60 MB","current-db-size-in-use-bytes":32165888,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-06T06:16:43.016975Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3977991745,"revision":33134,"compact-revision":30250} {"level":"info","ts":"2026-06-06T06:21:42.853362Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35383} {"level":"info","ts":"2026-06-06T06:21:43.001967Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35383,"took":"143.413489ms","hash":71997725,"current-db-size-bytes":59920384,"current-db-size":"60 MB","current-db-size-in-use-bytes":29335552,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-06T06:21:43.002068Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":71997725,"revision":35383,"compact-revision":33134} {"level":"info","ts":"2026-06-06T06:24:19.070566Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-06T06:24:19.075488Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-06T06:24:19.075624Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-06T06:26:42.862046Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37609} {"level":"info","ts":"2026-06-06T06:26:42.996832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37609,"took":"129.399741ms","hash":1717747788,"current-db-size-bytes":59920384,"current-db-size":"60 MB","current-db-size-in-use-bytes":30466048,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-06T06:26:42.996907Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1717747788,"revision":37609,"compact-revision":35383} {"level":"info","ts":"2026-06-06T06:31:42.867758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39956} {"level":"info","ts":"2026-06-06T06:31:42.99848Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39956,"took":"126.794418ms","hash":644287355,"current-db-size-bytes":60346368,"current-db-size":"60 MB","current-db-size-in-use-bytes":32112640,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-06T06:31:42.998552Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":644287355,"revision":39956,"compact-revision":37609} {"level":"info","ts":"2026-06-06T06:36:42.880856Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":42188} {"level":"info","ts":"2026-06-06T06:36:43.006038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":42188,"took":"120.435115ms","hash":2280340964,"current-db-size-bytes":61612032,"current-db-size":"62 MB","current-db-size-in-use-bytes":30826496,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-06T06:36:43.006109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2280340964,"revision":42188,"compact-revision":39956}