{"level":"warn","ts":"2026-06-09T22:23:47.694621Z","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-09T22:23:47.694723Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.132:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.132:2380","--initial-cluster=instance=https://199.19.213.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.132: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-09T22:23:47.694811Z","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-09T22:23:47.694829Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.132:2380"]} {"level":"info","ts":"2026-06-09T22:23:47.694853Z","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-09T22:23:47.695769Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.132:2379"]} {"level":"info","ts":"2026-06-09T22:23:47.695873Z","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.19.213.132:2380"],"listen-peer-urls":["https://199.19.213.132:2380"],"advertise-client-urls":["https://199.19.213.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.132: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-09T22:23:47.700174Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.017227ms"} {"level":"info","ts":"2026-06-09T22:23:47.707171Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"19a81b20c4b111c3","cluster-id":"42a0cab9df6b0eb"} {"level":"info","ts":"2026-06-09T22:23:47.70725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T22:23:47.707278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became follower at term 0"} {"level":"info","ts":"2026-06-09T22:23:47.707301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 19a81b20c4b111c3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T22:23:47.707316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became follower at term 1"} {"level":"info","ts":"2026-06-09T22:23:47.707356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 switched to configuration voters=(1848757474588430787)"} {"level":"warn","ts":"2026-06-09T22:23:47.713062Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T22:23:47.715425Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T22:23:47.71689Z","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-09T22:23:47.719036Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"19a81b20c4b111c3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T22:23:47.719198Z","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-09T22:23:47.719253Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"19a81b20c4b111c3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T22:23:47.719348Z","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-09T22:23:47.719368Z","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-09T22:23:47.722383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 switched to configuration voters=(1848757474588430787)"} {"level":"info","ts":"2026-06-09T22:23:47.722609Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"42a0cab9df6b0eb","local-member-id":"19a81b20c4b111c3","added-peer-id":"19a81b20c4b111c3","added-peer-peer-urls":["https://199.19.213.132:2380"]} {"level":"info","ts":"2026-06-09T22:23:47.723932Z","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-09T22:23:47.724113Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.132:2380"} {"level":"info","ts":"2026-06-09T22:23:47.724187Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.132:2380"} {"level":"info","ts":"2026-06-09T22:23:47.724192Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"19a81b20c4b111c3","initial-advertise-peer-urls":["https://199.19.213.132:2380"],"listen-peer-urls":["https://199.19.213.132:2380"],"advertise-client-urls":["https://199.19.213.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T22:23:47.724248Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T22:23:48.008546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T22:23:48.008609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T22:23:48.008641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 received MsgPreVoteResp from 19a81b20c4b111c3 at term 1"} {"level":"info","ts":"2026-06-09T22:23:48.008655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became candidate at term 2"} {"level":"info","ts":"2026-06-09T22:23:48.00866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 received MsgVoteResp from 19a81b20c4b111c3 at term 2"} {"level":"info","ts":"2026-06-09T22:23:48.008668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became leader at term 2"} {"level":"info","ts":"2026-06-09T22:23:48.008674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 19a81b20c4b111c3 elected leader 19a81b20c4b111c3 at term 2"} {"level":"info","ts":"2026-06-09T22:23:48.016689Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"19a81b20c4b111c3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.132:2379]}","request-path":"/0/members/19a81b20c4b111c3/attributes","cluster-id":"42a0cab9df6b0eb","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T22:23:48.016698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:23:48.016739Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:23:48.016733Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:48.01777Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"42a0cab9df6b0eb","local-member-id":"19a81b20c4b111c3","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:48.017985Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:48.01804Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:48.019548Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T22:23:48.019954Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.132:2379"} {"level":"info","ts":"2026-06-09T22:23:48.020551Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T22:23:48.020578Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T22:24:03.318672Z","caller":"traceutil/trace.go:171","msg":"trace[196598443] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"184.881903ms","start":"2026-06-09T22:24:03.133762Z","end":"2026-06-09T22:24:03.318643Z","steps":["trace[196598443] 'process raft request' (duration: 184.70865ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:31.468094Z","caller":"traceutil/trace.go:171","msg":"trace[486942063] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"140.0941ms","start":"2026-06-09T22:24:31.327972Z","end":"2026-06-09T22:24:31.468066Z","steps":["trace[486942063] 'process raft request' (duration: 138.833346ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:31.694079Z","caller":"traceutil/trace.go:171","msg":"trace[1242283963] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"149.092071ms","start":"2026-06-09T22:24:31.544963Z","end":"2026-06-09T22:24:31.694055Z","steps":["trace[1242283963] 'read index received' (duration: 54.016849ms)","trace[1242283963] 'applied index is now lower than readState.Index' (duration: 95.071882ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:24:31.694262Z","caller":"traceutil/trace.go:171","msg":"trace[2025890728] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"162.331424ms","start":"2026-06-09T22:24:31.531862Z","end":"2026-06-09T22:24:31.694194Z","steps":["trace[2025890728] 'process raft request' (duration: 67.272362ms)","trace[2025890728] 'compare' (duration: 94.783116ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:24:31.694322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.349046ms","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-09T22:24:31.694413Z","caller":"traceutil/trace.go:171","msg":"trace[1650871562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"149.491928ms","start":"2026-06-09T22:24:31.544907Z","end":"2026-06-09T22:24:31.694399Z","steps":["trace[1650871562] 'agreement among raft nodes before linearized reading' (duration: 149.281555ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:32.180183Z","caller":"traceutil/trace.go:171","msg":"trace[1058957964] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"102.237549ms","start":"2026-06-09T22:24:32.077912Z","end":"2026-06-09T22:24:32.18015Z","steps":["trace[1058957964] 'process raft request' (duration: 101.964164ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:32.476231Z","caller":"traceutil/trace.go:171","msg":"trace[80898423] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"358.559443ms","start":"2026-06-09T22:24:32.117636Z","end":"2026-06-09T22:24:32.476195Z","steps":["trace[80898423] 'process raft request' (duration: 357.603025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:24:32.477154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:24:32.11761Z","time spent":"358.730006ms","remote":"127.0.0.1:35276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:24:32.797611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.632313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:24:32.797758Z","caller":"traceutil/trace.go:171","msg":"trace[343125761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"127.849237ms","start":"2026-06-09T22:24:32.669865Z","end":"2026-06-09T22:24:32.797714Z","steps":["trace[343125761] 'range keys from in-memory index tree' (duration: 127.532821ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:47.10809Z","caller":"traceutil/trace.go:171","msg":"trace[2008963765] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"177.270579ms","start":"2026-06-09T22:24:46.930794Z","end":"2026-06-09T22:24:47.108064Z","steps":["trace[2008963765] 'process raft request' (duration: 177.115076ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:14.537253Z","caller":"traceutil/trace.go:171","msg":"trace[1973642178] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"128.542329ms","start":"2026-06-09T22:25:14.408676Z","end":"2026-06-09T22:25:14.537218Z","steps":["trace[1973642178] 'process raft request' (duration: 128.260313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:00.945456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.427964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:26:00.945596Z","caller":"traceutil/trace.go:171","msg":"trace[2059398346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1804; }","duration":"276.624178ms","start":"2026-06-09T22:26:00.668952Z","end":"2026-06-09T22:26:00.945576Z","steps":["trace[2059398346] 'range keys from in-memory index tree' (duration: 276.328193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:00.945684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.722674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10630"} {"level":"info","ts":"2026-06-09T22:26:00.945774Z","caller":"traceutil/trace.go:171","msg":"trace[551827624] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1804; }","duration":"243.863397ms","start":"2026-06-09T22:26:00.701888Z","end":"2026-06-09T22:26:00.945751Z","steps":["trace[551827624] 'range keys from in-memory index tree' (duration: 243.48225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:00.945844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.191526ms","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-09T22:26:00.945975Z","caller":"traceutil/trace.go:171","msg":"trace[651283332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1804; }","duration":"192.340008ms","start":"2026-06-09T22:26:00.753614Z","end":"2026-06-09T22:26:00.945954Z","steps":["trace[651283332] 'range keys from in-memory index tree' (duration: 191.988902ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:26:01.094138Z","caller":"traceutil/trace.go:171","msg":"trace[1552832988] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"109.872735ms","start":"2026-06-09T22:26:00.984222Z","end":"2026-06-09T22:26:01.094095Z","steps":["trace[1552832988] 'process raft request' (duration: 76.642744ms)","trace[1552832988] 'compare' (duration: 32.794053ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:26:01.094508Z","caller":"traceutil/trace.go:171","msg":"trace[625438414] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"110.000437ms","start":"2026-06-09T22:26:00.984204Z","end":"2026-06-09T22:26:01.094205Z","steps":["trace[625438414] 'process raft request' (duration: 109.914325ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:26:01.120385Z","caller":"traceutil/trace.go:171","msg":"trace[1601775205] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"129.222733ms","start":"2026-06-09T22:26:00.99114Z","end":"2026-06-09T22:26:01.120363Z","steps":["trace[1601775205] 'process raft request' (duration: 129.166611ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:26:01.120461Z","caller":"traceutil/trace.go:171","msg":"trace[124682866] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"135.233057ms","start":"2026-06-09T22:26:00.985184Z","end":"2026-06-09T22:26:01.120417Z","steps":["trace[124682866] 'process raft request' (duration: 135.025672ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:26:01.120367Z","caller":"traceutil/trace.go:171","msg":"trace[16055541] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"135.95477ms","start":"2026-06-09T22:26:00.984377Z","end":"2026-06-09T22:26:01.120331Z","steps":["trace[16055541] 'process raft request' (duration: 135.691814ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:28:14.474947Z","caller":"traceutil/trace.go:171","msg":"trace[1291064507] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"172.865254ms","start":"2026-06-09T22:28:14.302058Z","end":"2026-06-09T22:28:14.474923Z","steps":["trace[1291064507] 'process raft request' (duration: 172.727021ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:28:14.559896Z","caller":"traceutil/trace.go:171","msg":"trace[1500011968] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"212.110928ms","start":"2026-06-09T22:28:14.347761Z","end":"2026-06-09T22:28:14.559872Z","steps":["trace[1500011968] 'process raft request' (duration: 211.650399ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:28:14.560195Z","caller":"traceutil/trace.go:171","msg":"trace[1423132706] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"113.74788ms","start":"2026-06-09T22:28:14.446415Z","end":"2026-06-09T22:28:14.560163Z","steps":["trace[1423132706] 'process raft request' (duration: 113.416394ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:39.858225Z","caller":"traceutil/trace.go:171","msg":"trace[884346374] transaction","detail":"{read_only:false; response_revision:3742; number_of_response:1; }","duration":"133.138391ms","start":"2026-06-09T22:30:39.725057Z","end":"2026-06-09T22:30:39.858195Z","steps":["trace[884346374] 'process raft request' (duration: 132.931497ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:22.013899Z","caller":"traceutil/trace.go:171","msg":"trace[2007891609] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"189.458397ms","start":"2026-06-09T22:32:21.824373Z","end":"2026-06-09T22:32:22.013831Z","steps":["trace[2007891609] 'process raft request' (duration: 152.479275ms)","trace[2007891609] 'compare' (duration: 36.795619ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:32:22.02522Z","caller":"traceutil/trace.go:171","msg":"trace[1145468226] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"200.12701ms","start":"2026-06-09T22:32:21.82507Z","end":"2026-06-09T22:32:22.025197Z","steps":["trace[1145468226] 'process raft request' (duration: 199.865285ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:22.025507Z","caller":"traceutil/trace.go:171","msg":"trace[645645109] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"193.944202ms","start":"2026-06-09T22:32:21.831516Z","end":"2026-06-09T22:32:22.02546Z","steps":["trace[645645109] 'process raft request' (duration: 193.591715ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:22.025626Z","caller":"traceutil/trace.go:171","msg":"trace[1944694016] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"193.942782ms","start":"2026-06-09T22:32:21.831628Z","end":"2026-06-09T22:32:22.02557Z","steps":["trace[1944694016] 'process raft request' (duration: 193.691877ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:22.025889Z","caller":"traceutil/trace.go:171","msg":"trace[1454681018] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"194.108405ms","start":"2026-06-09T22:32:21.831767Z","end":"2026-06-09T22:32:22.025875Z","steps":["trace[1454681018] 'process raft request' (duration: 193.729838ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:29.929724Z","caller":"traceutil/trace.go:171","msg":"trace[2048100936] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"168.805544ms","start":"2026-06-09T22:32:29.760855Z","end":"2026-06-09T22:32:29.92966Z","steps":["trace[2048100936] 'process raft request' (duration: 168.522819ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.065033Z","caller":"traceutil/trace.go:171","msg":"trace[1722233677] linearizableReadLoop","detail":"{readStateIndex:5564; appliedIndex:5563; }","duration":"135.388931ms","start":"2026-06-09T22:32:29.929616Z","end":"2026-06-09T22:32:30.065005Z","steps":["trace[1722233677] 'read index received' (duration: 42.558009ms)","trace[1722233677] 'applied index is now lower than readState.Index' (duration: 92.829432ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:32:30.065066Z","caller":"traceutil/trace.go:171","msg":"trace[997911592] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"195.986501ms","start":"2026-06-09T22:32:29.869039Z","end":"2026-06-09T22:32:30.065026Z","steps":["trace[997911592] 'process raft request' (duration: 103.178699ms)","trace[997911592] 'compare' (duration: 92.593488ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:32:30.065342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.490911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-09T22:32:30.065451Z","caller":"traceutil/trace.go:171","msg":"trace[1358995538] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5359; }","duration":"205.650785ms","start":"2026-06-09T22:32:29.859776Z","end":"2026-06-09T22:32:30.065427Z","steps":["trace[1358995538] 'agreement among raft nodes before linearized reading' (duration: 205.35759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:30.109872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.220545ms","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:7"} {"level":"info","ts":"2026-06-09T22:32:30.109979Z","caller":"traceutil/trace.go:171","msg":"trace[957528267] transaction","detail":"{read_only:false; response_revision:5360; number_of_response:1; }","duration":"171.534697ms","start":"2026-06-09T22:32:29.938411Z","end":"2026-06-09T22:32:30.109945Z","steps":["trace[957528267] 'process raft request' (duration: 171.17396ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.110029Z","caller":"traceutil/trace.go:171","msg":"trace[383616711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5360; }","duration":"147.396299ms","start":"2026-06-09T22:32:29.962613Z","end":"2026-06-09T22:32:30.110009Z","steps":["trace[383616711] 'agreement among raft nodes before linearized reading' (duration: 147.174755ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.276559Z","caller":"traceutil/trace.go:171","msg":"trace[840118944] transaction","detail":"{read_only:false; response_revision:5361; number_of_response:1; }","duration":"160.378304ms","start":"2026-06-09T22:32:30.116164Z","end":"2026-06-09T22:32:30.276542Z","steps":["trace[840118944] 'process raft request' (duration: 160.215331ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.287371Z","caller":"traceutil/trace.go:171","msg":"trace[994490498] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"170.997647ms","start":"2026-06-09T22:32:30.116354Z","end":"2026-06-09T22:32:30.287352Z","steps":["trace[994490498] 'process raft request' (duration: 170.803643ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.287513Z","caller":"traceutil/trace.go:171","msg":"trace[1425235455] transaction","detail":"{read_only:false; response_revision:5364; number_of_response:1; }","duration":"170.68827ms","start":"2026-06-09T22:32:30.116814Z","end":"2026-06-09T22:32:30.287502Z","steps":["trace[1425235455] 'process raft request' (duration: 170.505517ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.287883Z","caller":"traceutil/trace.go:171","msg":"trace[1521333123] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"170.571119ms","start":"2026-06-09T22:32:30.117271Z","end":"2026-06-09T22:32:30.287842Z","steps":["trace[1521333123] 'process raft request' (duration: 170.162781ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.287935Z","caller":"traceutil/trace.go:171","msg":"trace[1070893285] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"170.404995ms","start":"2026-06-09T22:32:30.117517Z","end":"2026-06-09T22:32:30.287922Z","steps":["trace[1070893285] 'process raft request' (duration: 169.992408ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.287761Z","caller":"traceutil/trace.go:171","msg":"trace[142081506] linearizableReadLoop","detail":"{readStateIndex:5567; appliedIndex:5565; }","duration":"171.334293ms","start":"2026-06-09T22:32:30.116403Z","end":"2026-06-09T22:32:30.287737Z","steps":["trace[142081506] 'read index received' (duration: 160.072959ms)","trace[142081506] 'applied index is now lower than readState.Index' (duration: 11.260304ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:32:30.288103Z","caller":"traceutil/trace.go:171","msg":"trace[1249427487] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"170.796562ms","start":"2026-06-09T22:32:30.117293Z","end":"2026-06-09T22:32:30.288089Z","steps":["trace[1249427487] 'process raft request' (duration: 170.172961ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.288172Z","caller":"traceutil/trace.go:171","msg":"trace[1647783783] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"170.593379ms","start":"2026-06-09T22:32:30.117561Z","end":"2026-06-09T22:32:30.288154Z","steps":["trace[1647783783] 'process raft request' (duration: 170.026858ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.288204Z","caller":"traceutil/trace.go:171","msg":"trace[928019788] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"171.20247ms","start":"2026-06-09T22:32:30.116987Z","end":"2026-06-09T22:32:30.288189Z","steps":["trace[928019788] 'process raft request' (duration: 170.414086ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.288181Z","caller":"traceutil/trace.go:171","msg":"trace[1749587643] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"171.265792ms","start":"2026-06-09T22:32:30.116886Z","end":"2026-06-09T22:32:30.288152Z","steps":["trace[1749587643] 'process raft request' (duration: 170.481057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:30.288481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.051317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80105"} {"level":"info","ts":"2026-06-09T22:32:30.288549Z","caller":"traceutil/trace.go:171","msg":"trace[602624607] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5370; }","duration":"172.156809ms","start":"2026-06-09T22:32:30.11638Z","end":"2026-06-09T22:32:30.288536Z","steps":["trace[602624607] 'agreement among raft nodes before linearized reading' (duration: 171.895833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:30.288565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.144579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8be211c6-31b1-49de-a152-f3c63a64f0f5\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-09T22:32:30.28861Z","caller":"traceutil/trace.go:171","msg":"trace[1919863594] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8be211c6-31b1-49de-a152-f3c63a64f0f5; range_end:; response_count:1; response_revision:5370; }","duration":"172.237561ms","start":"2026-06-09T22:32:30.11636Z","end":"2026-06-09T22:32:30.288597Z","steps":["trace[1919863594] 'agreement among raft nodes before linearized reading' (duration: 172.040266ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:30.288764Z","caller":"traceutil/trace.go:171","msg":"trace[968014442] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"171.104528ms","start":"2026-06-09T22:32:30.116769Z","end":"2026-06-09T22:32:30.287873Z","steps":["trace[968014442] 'process raft request' (duration: 170.500957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:41.400883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.306477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:32:41.401004Z","caller":"traceutil/trace.go:171","msg":"trace[893357146] linearizableReadLoop","detail":"{readStateIndex:5722; appliedIndex:5721; }","duration":"167.14228ms","start":"2026-06-09T22:32:41.233844Z","end":"2026-06-09T22:32:41.400986Z","steps":["trace[893357146] 'read index received' (duration: 22.487087ms)","trace[893357146] 'applied index is now lower than readState.Index' (duration: 144.654103ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:32:41.401055Z","caller":"traceutil/trace.go:171","msg":"trace[804875205] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"218.711819ms","start":"2026-06-09T22:32:41.182304Z","end":"2026-06-09T22:32:41.401016Z","steps":["trace[804875205] 'process raft request' (duration: 74.027265ms)","trace[804875205] 'compare' (duration: 144.143544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:32:41.401145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.302403ms","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:7"} {"level":"info","ts":"2026-06-09T22:32:41.401265Z","caller":"traceutil/trace.go:171","msg":"trace[1961108165] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5513; }","duration":"167.460176ms","start":"2026-06-09T22:32:41.233792Z","end":"2026-06-09T22:32:41.401252Z","steps":["trace[1961108165] 'agreement among raft nodes before linearized reading' (duration: 167.280903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:41.401589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.467032ms","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-09T22:32:41.401734Z","caller":"traceutil/trace.go:171","msg":"trace[1695979645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5513; }","duration":"143.652355ms","start":"2026-06-09T22:32:41.258052Z","end":"2026-06-09T22:32:41.401704Z","steps":["trace[1695979645] 'agreement among raft nodes before linearized reading' (duration: 143.103994ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:33:48.223598Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2959} {"level":"info","ts":"2026-06-09T22:33:48.289821Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2959,"took":"64.757369ms","hash":2674095662,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":34119680,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-09T22:33:48.289876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2674095662,"revision":2959,"compact-revision":-1} {"level":"info","ts":"2026-06-09T22:38:39.475447Z","caller":"traceutil/trace.go:171","msg":"trace[1157719035] transaction","detail":"{read_only:false; response_revision:8208; number_of_response:1; }","duration":"109.844741ms","start":"2026-06-09T22:38:39.365578Z","end":"2026-06-09T22:38:39.475423Z","steps":["trace[1157719035] 'process raft request' (duration: 88.081039ms)","trace[1157719035] 'compare' (duration: 21.602269ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:38:40.269657Z","caller":"traceutil/trace.go:171","msg":"trace[388995321] transaction","detail":"{read_only:false; response_revision:8209; number_of_response:1; }","duration":"101.933382ms","start":"2026-06-09T22:38:40.167687Z","end":"2026-06-09T22:38:40.269621Z","steps":["trace[388995321] 'process raft request' (duration: 101.669947ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:40.273675Z","caller":"traceutil/trace.go:171","msg":"trace[1106779955] transaction","detail":"{read_only:false; response_revision:8210; number_of_response:1; }","duration":"105.436938ms","start":"2026-06-09T22:38:40.168205Z","end":"2026-06-09T22:38:40.273642Z","steps":["trace[1106779955] 'process raft request' (duration: 105.232495ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:40.273849Z","caller":"traceutil/trace.go:171","msg":"trace[2027067341] linearizableReadLoop","detail":"{readStateIndex:8503; appliedIndex:8500; }","duration":"104.055751ms","start":"2026-06-09T22:38:40.169755Z","end":"2026-06-09T22:38:40.273811Z","steps":["trace[2027067341] 'read index received' (duration: 99.635497ms)","trace[2027067341] 'applied index is now lower than readState.Index' (duration: 4.418834ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:38:40.274111Z","caller":"traceutil/trace.go:171","msg":"trace[104113937] transaction","detail":"{read_only:false; response_revision:8211; number_of_response:1; }","duration":"105.879377ms","start":"2026-06-09T22:38:40.168219Z","end":"2026-06-09T22:38:40.274098Z","steps":["trace[104113937] 'process raft request' (duration: 105.368337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:40.274539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.730884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-09T22:38:40.274669Z","caller":"traceutil/trace.go:171","msg":"trace[1010957710] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8211; }","duration":"104.907058ms","start":"2026-06-09T22:38:40.169729Z","end":"2026-06-09T22:38:40.274636Z","steps":["trace[1010957710] 'agreement among raft nodes before linearized reading' (duration: 104.5034ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:48.232409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6087} {"level":"info","ts":"2026-06-09T22:38:48.331914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6087,"took":"96.325105ms","hash":2971344641,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":23212032,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-09T22:38:48.331985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2971344641,"revision":6087,"compact-revision":2959} {"level":"warn","ts":"2026-06-09T22:39:07.648097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.072685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:39:07.648182Z","caller":"traceutil/trace.go:171","msg":"trace[1556859232] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:8414; }","duration":"178.215947ms","start":"2026-06-09T22:39:07.469949Z","end":"2026-06-09T22:39:07.648165Z","steps":["trace[1556859232] 'count revisions from in-memory index tree' (duration: 177.923362ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:40:10.215208Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243e.wal"} {"level":"info","ts":"2026-06-09T22:41:29.253543Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"19a81b20c4b111c3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T22:41:29.258583Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-09T22:41:29.258683Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-09T22:43:48.237644Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8259} {"level":"info","ts":"2026-06-09T22:43:48.317442Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8259,"took":"77.960037ms","hash":1832054397,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":26374144,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-09T22:43:48.317502Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1832054397,"revision":8259,"compact-revision":6087} {"level":"info","ts":"2026-06-09T22:48:48.245261Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10890} {"level":"info","ts":"2026-06-09T22:48:48.324288Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10890,"took":"77.022343ms","hash":2919419456,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":27791360,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-09T22:48:48.324342Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2919419456,"revision":10890,"compact-revision":8259} {"level":"info","ts":"2026-06-09T22:51:00.444204Z","caller":"traceutil/trace.go:171","msg":"trace[338013206] transaction","detail":"{read_only:false; response_revision:13987; number_of_response:1; }","duration":"216.339938ms","start":"2026-06-09T22:51:00.227837Z","end":"2026-06-09T22:51:00.444177Z","steps":["trace[338013206] 'process raft request' (duration: 216.177365ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:51:00.456687Z","caller":"traceutil/trace.go:171","msg":"trace[280426393] transaction","detail":"{read_only:false; response_revision:13988; number_of_response:1; }","duration":"225.082335ms","start":"2026-06-09T22:51:00.231572Z","end":"2026-06-09T22:51:00.456654Z","steps":["trace[280426393] 'process raft request' (duration: 224.876321ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:53:48.250593Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12959} {"level":"info","ts":"2026-06-09T22:53:48.328508Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12959,"took":"75.652767ms","hash":2554076913,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":30900224,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-09T22:53:48.328558Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2554076913,"revision":12959,"compact-revision":10890} {"level":"info","ts":"2026-06-09T22:58:08.976973Z","caller":"traceutil/trace.go:171","msg":"trace[1628338839] transaction","detail":"{read_only:false; response_revision:17354; number_of_response:1; }","duration":"155.276841ms","start":"2026-06-09T22:58:08.821626Z","end":"2026-06-09T22:58:08.976903Z","steps":["trace[1628338839] 'process raft request' (duration: 155.033777ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:09.101028Z","caller":"traceutil/trace.go:171","msg":"trace[81708403] transaction","detail":"{read_only:false; response_revision:17355; number_of_response:1; }","duration":"108.718274ms","start":"2026-06-09T22:58:08.992283Z","end":"2026-06-09T22:58:09.101002Z","steps":["trace[81708403] 'process raft request' (duration: 108.566301ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:09.440015Z","caller":"traceutil/trace.go:171","msg":"trace[204514630] transaction","detail":"{read_only:false; response_revision:17356; number_of_response:1; }","duration":"172.365577ms","start":"2026-06-09T22:58:09.267622Z","end":"2026-06-09T22:58:09.439987Z","steps":["trace[204514630] 'process raft request' (duration: 119.980477ms)","trace[204514630] 'compare' (duration: 51.916051ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:58:09.44018Z","caller":"traceutil/trace.go:171","msg":"trace[2004816675] transaction","detail":"{read_only:false; response_revision:17357; number_of_response:1; }","duration":"162.556771ms","start":"2026-06-09T22:58:09.277576Z","end":"2026-06-09T22:58:09.440133Z","steps":["trace[2004816675] 'process raft request' (duration: 162.304786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.128591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.33364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-09T22:58:10.128916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.144548ms","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-09T22:58:10.128993Z","caller":"traceutil/trace.go:171","msg":"trace[82406922] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:17357; }","duration":"296.2155ms","start":"2026-06-09T22:58:09.832762Z","end":"2026-06-09T22:58:10.128978Z","steps":["trace[82406922] 'range keys from in-memory index tree' (duration: 296.133798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.129484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.134949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"warn","ts":"2026-06-09T22:58:10.129521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.337604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T22:58:10.129575Z","caller":"traceutil/trace.go:171","msg":"trace[1288654518] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:17357; }","duration":"208.22538ms","start":"2026-06-09T22:58:09.921311Z","end":"2026-06-09T22:58:10.129536Z","steps":["trace[1288654518] 'range keys from in-memory index tree' (duration: 207.970136ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:10.129606Z","caller":"traceutil/trace.go:171","msg":"trace[1635658043] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:17357; }","duration":"368.469087ms","start":"2026-06-09T22:58:09.761116Z","end":"2026-06-09T22:58:10.129585Z","steps":["trace[1635658043] 'count revisions from in-memory index tree' (duration: 368.261973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.129628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.139539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T22:58:10.129681Z","caller":"traceutil/trace.go:171","msg":"trace[1401396499] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:0; response_revision:17357; }","duration":"380.232071ms","start":"2026-06-09T22:58:09.749433Z","end":"2026-06-09T22:58:10.129665Z","steps":["trace[1401396499] 'range keys from in-memory index tree' (duration: 380.058927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.129684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.581844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-988fj\" ","response":"range_response_count:1 size:22133"} {"level":"warn","ts":"2026-06-09T22:58:10.129679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:58:09.761098Z","time spent":"368.566229ms","remote":"127.0.0.1:35588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-09T22:58:10.129725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:58:09.749412Z","time spent":"380.303763ms","remote":"127.0.0.1:40306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" "} {"level":"info","ts":"2026-06-09T22:58:10.129731Z","caller":"traceutil/trace.go:171","msg":"trace[364500666] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-988fj; range_end:; response_count:1; response_revision:17357; }","duration":"482.692896ms","start":"2026-06-09T22:58:09.647026Z","end":"2026-06-09T22:58:10.129719Z","steps":["trace[364500666] 'range keys from in-memory index tree' (duration: 482.40743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.129784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:58:09.646994Z","time spent":"482.781947ms","remote":"127.0.0.1:35376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22155,"request content":"key:\"/registry/pods/openstack/nova-compute-default-988fj\" "} {"level":"warn","ts":"2026-06-09T22:58:10.129799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.495836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-09T22:58:10.129823Z","caller":"traceutil/trace.go:171","msg":"trace[678417436] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:17357; }","duration":"272.572077ms","start":"2026-06-09T22:58:09.857244Z","end":"2026-06-09T22:58:10.129816Z","steps":["trace[678417436] 'count revisions from in-memory index tree' (duration: 272.399895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.129086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.92666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T22:58:10.12869Z","caller":"traceutil/trace.go:171","msg":"trace[2102324122] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:17357; }","duration":"577.480863ms","start":"2026-06-09T22:58:09.551189Z","end":"2026-06-09T22:58:10.12867Z","steps":["trace[2102324122] 'count revisions from in-memory index tree' (duration: 577.154456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.130268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:58:09.551166Z","time spent":"579.090903ms","remote":"127.0.0.1:40328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-06-09T22:58:10.130118Z","caller":"traceutil/trace.go:171","msg":"trace[771653130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17357; }","duration":"463.075981ms","start":"2026-06-09T22:58:09.667027Z","end":"2026-06-09T22:58:10.130103Z","steps":["trace[771653130] 'range keys from in-memory index tree' (duration: 461.697565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.130625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:58:09.667007Z","time spent":"463.604172ms","remote":"127.0.0.1:35166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T22:58:10.224633Z","caller":"traceutil/trace.go:171","msg":"trace[1565978804] linearizableReadLoop","detail":"{readStateIndex:17947; appliedIndex:17946; }","duration":"134.894032ms","start":"2026-06-09T22:58:10.089705Z","end":"2026-06-09T22:58:10.224599Z","steps":["trace[1565978804] 'read index received' (duration: 134.473154ms)","trace[1565978804] 'applied index is now lower than readState.Index' (duration: 418.628µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:58:10.224683Z","caller":"traceutil/trace.go:171","msg":"trace[730052220] transaction","detail":"{read_only:false; response_revision:17358; number_of_response:1; }","duration":"260.60372ms","start":"2026-06-09T22:58:09.964041Z","end":"2026-06-09T22:58:10.224645Z","steps":["trace[730052220] 'process raft request' (duration: 260.250744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.224944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.174037ms","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-09T22:58:10.225054Z","caller":"traceutil/trace.go:171","msg":"trace[591525585] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17358; }","duration":"135.379652ms","start":"2026-06-09T22:58:10.089659Z","end":"2026-06-09T22:58:10.225039Z","steps":["trace[591525585] 'agreement among raft nodes before linearized reading' (duration: 135.107486ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:10.330805Z","caller":"traceutil/trace.go:171","msg":"trace[1932370147] transaction","detail":"{read_only:false; response_revision:17359; number_of_response:1; }","duration":"195.993988ms","start":"2026-06-09T22:58:10.13477Z","end":"2026-06-09T22:58:10.330764Z","steps":["trace[1932370147] 'process raft request' (duration: 195.762023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.331037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.723434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T22:58:10.331105Z","caller":"traceutil/trace.go:171","msg":"trace[1026650694] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:17360; }","duration":"193.811646ms","start":"2026-06-09T22:58:10.137276Z","end":"2026-06-09T22:58:10.331088Z","steps":["trace[1026650694] 'agreement among raft nodes before linearized reading' (duration: 193.705344ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:10.331186Z","caller":"traceutil/trace.go:171","msg":"trace[1115912023] transaction","detail":"{read_only:false; response_revision:17360; number_of_response:1; }","duration":"172.350946ms","start":"2026-06-09T22:58:10.158824Z","end":"2026-06-09T22:58:10.331175Z","steps":["trace[1115912023] 'process raft request' (duration: 171.896178ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:10.331017Z","caller":"traceutil/trace.go:171","msg":"trace[1083657796] linearizableReadLoop","detail":"{readStateIndex:17949; appliedIndex:17947; }","duration":"106.244446ms","start":"2026-06-09T22:58:10.224723Z","end":"2026-06-09T22:58:10.330968Z","steps":["trace[1083657796] 'read index received' (duration: 105.859108ms)","trace[1083657796] 'applied index is now lower than readState.Index' (duration: 383.128µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:58:10.331231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.50844ms","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-09T22:58:10.331298Z","caller":"traceutil/trace.go:171","msg":"trace[1860051890] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17360; }","duration":"237.599701ms","start":"2026-06-09T22:58:10.093682Z","end":"2026-06-09T22:58:10.331281Z","steps":["trace[1860051890] 'agreement among raft nodes before linearized reading' (duration: 237.403348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.331595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.61767ms","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-09T22:58:10.331655Z","caller":"traceutil/trace.go:171","msg":"trace[1640535857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17360; }","duration":"163.701641ms","start":"2026-06-09T22:58:10.167935Z","end":"2026-06-09T22:58:10.331637Z","steps":["trace[1640535857] 'agreement among raft nodes before linearized reading' (duration: 163.220262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.331908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.045534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T22:58:10.33204Z","caller":"traceutil/trace.go:171","msg":"trace[1655473827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17360; }","duration":"200.210689ms","start":"2026-06-09T22:58:10.131795Z","end":"2026-06-09T22:58:10.332005Z","steps":["trace[1655473827] 'agreement among raft nodes before linearized reading' (duration: 199.25141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:58:10.332723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.786303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946120"} {"level":"info","ts":"2026-06-09T22:58:10.332819Z","caller":"traceutil/trace.go:171","msg":"trace[1571468949] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:17360; }","duration":"196.903476ms","start":"2026-06-09T22:58:10.135894Z","end":"2026-06-09T22:58:10.332797Z","steps":["trace[1571468949] 'agreement among raft nodes before linearized reading' (duration: 195.124342ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:10.339559Z","caller":"traceutil/trace.go:171","msg":"trace[1965834203] transaction","detail":"{read_only:false; response_revision:17361; number_of_response:1; }","duration":"109.134251ms","start":"2026-06-09T22:58:10.230404Z","end":"2026-06-09T22:58:10.339538Z","steps":["trace[1965834203] 'process raft request' (duration: 109.008889ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:48.259572Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15346} {"level":"info","ts":"2026-06-09T22:58:48.35747Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15346,"took":"95.049133ms","hash":755922162,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":33435648,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-09T22:58:48.357575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":755922162,"revision":15346,"compact-revision":12959} {"level":"info","ts":"2026-06-09T22:59:06.166532Z","caller":"traceutil/trace.go:171","msg":"trace[1739697946] transaction","detail":"{read_only:false; response_revision:18053; number_of_response:1; }","duration":"105.269218ms","start":"2026-06-09T22:59:06.061231Z","end":"2026-06-09T22:59:06.1665Z","steps":["trace[1739697946] 'process raft request' (duration: 105.110355ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:01:59.465471Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"19a81b20c4b111c3","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:01:59.475775Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-09T23:01:59.476199Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-09T23:03:47.727582Z","caller":"traceutil/trace.go:171","msg":"trace[1637697198] transaction","detail":"{read_only:false; response_revision:20061; number_of_response:1; }","duration":"150.047159ms","start":"2026-06-09T23:03:47.577498Z","end":"2026-06-09T23:03:47.727545Z","steps":["trace[1637697198] 'process raft request' (duration: 149.779234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.205374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.213036ms","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-09T23:03:48.205456Z","caller":"traceutil/trace.go:171","msg":"trace[1452714683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20062; }","duration":"147.335087ms","start":"2026-06-09T23:03:48.058102Z","end":"2026-06-09T23:03:48.205437Z","steps":["trace[1452714683] 'range keys from in-memory index tree' (duration: 147.049322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.205733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.307611ms","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-09T23:03:48.205782Z","caller":"traceutil/trace.go:171","msg":"trace[1321720111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20062; }","duration":"143.375092ms","start":"2026-06-09T23:03:48.062397Z","end":"2026-06-09T23:03:48.205772Z","steps":["trace[1321720111] 'range keys from in-memory index tree' (duration: 143.198758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.206011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.515252ms","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-09T23:03:48.206059Z","caller":"traceutil/trace.go:171","msg":"trace[705772142] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20062; }","duration":"136.577733ms","start":"2026-06-09T23:03:48.069468Z","end":"2026-06-09T23:03:48.206045Z","steps":["trace[705772142] 'range keys from in-memory index tree' (duration: 136.43138ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.430954Z","caller":"traceutil/trace.go:171","msg":"trace[1764178967] transaction","detail":"{read_only:false; response_revision:20064; number_of_response:1; }","duration":"210.500681ms","start":"2026-06-09T23:03:48.220405Z","end":"2026-06-09T23:03:48.430905Z","steps":["trace[1764178967] 'process raft request' (duration: 210.357039ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.466537Z","caller":"traceutil/trace.go:171","msg":"trace[2110932802] linearizableReadLoop","detail":"{readStateIndex:20741; appliedIndex:20738; }","duration":"166.937331ms","start":"2026-06-09T23:03:48.299573Z","end":"2026-06-09T23:03:48.46651Z","steps":["trace[2110932802] 'read index received' (duration: 131.260671ms)","trace[2110932802] 'applied index is now lower than readState.Index' (duration: 35.6755ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:03:48.466624Z","caller":"traceutil/trace.go:171","msg":"trace[1078134822] transaction","detail":"{read_only:false; response_revision:20065; number_of_response:1; }","duration":"242.389019ms","start":"2026-06-09T23:03:48.224201Z","end":"2026-06-09T23:03:48.46659Z","steps":["trace[1078134822] 'process raft request' (duration: 242.088343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.466928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.666812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-09T23:03:48.466948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.309008ms","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-09T23:03:48.467012Z","caller":"traceutil/trace.go:171","msg":"trace[30224768] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:20066; }","duration":"117.810625ms","start":"2026-06-09T23:03:48.349185Z","end":"2026-06-09T23:03:48.466995Z","steps":["trace[30224768] 'agreement among raft nodes before linearized reading' (duration: 117.625682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.467029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.603038ms","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-09T23:03:48.467116Z","caller":"traceutil/trace.go:171","msg":"trace[362508698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20066; }","duration":"109.726441ms","start":"2026-06-09T23:03:48.357356Z","end":"2026-06-09T23:03:48.467083Z","steps":["trace[362508698] 'agreement among raft nodes before linearized reading' (duration: 109.523097ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.467056Z","caller":"traceutil/trace.go:171","msg":"trace[1870467625] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20066; }","duration":"167.505782ms","start":"2026-06-09T23:03:48.299529Z","end":"2026-06-09T23:03:48.467035Z","steps":["trace[1870467625] 'agreement among raft nodes before linearized reading' (duration: 167.109365ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.467402Z","caller":"traceutil/trace.go:171","msg":"trace[1582388465] transaction","detail":"{read_only:false; response_revision:20066; number_of_response:1; }","duration":"205.453374ms","start":"2026-06-09T23:03:48.261179Z","end":"2026-06-09T23:03:48.466633Z","steps":["trace[1582388465] 'process raft request' (duration: 205.273171ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.625447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17887} {"level":"warn","ts":"2026-06-09T23:03:48.627449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.008713ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:6"} {"level":"info","ts":"2026-06-09T23:03:48.627586Z","caller":"traceutil/trace.go:171","msg":"trace[1411326450] linearizableReadLoop","detail":"{readStateIndex:20742; appliedIndex:20741; }","duration":"156.715197ms","start":"2026-06-09T23:03:48.470855Z","end":"2026-06-09T23:03:48.627571Z","steps":["trace[1411326450] 'read index received' (duration: 19.288418ms)","trace[1411326450] 'applied index is now lower than readState.Index' (duration: 137.425829ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:03:48.627673Z","caller":"traceutil/trace.go:171","msg":"trace[1578118202] compact","detail":"{revision:17887; response_revision:20066; }","duration":"159.208073ms","start":"2026-06-09T23:03:48.468458Z","end":"2026-06-09T23:03:48.627666Z","steps":["trace[1578118202] 'check and update compact revision' (duration: 134.933291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.627996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.132034ms","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-09T23:03:48.628034Z","caller":"traceutil/trace.go:171","msg":"trace[659873073] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20066; }","duration":"157.191265ms","start":"2026-06-09T23:03:48.470833Z","end":"2026-06-09T23:03:48.628024Z","steps":["trace[659873073] 'agreement among raft nodes before linearized reading' (duration: 157.068783ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.628533Z","caller":"traceutil/trace.go:171","msg":"trace[1048700193] transaction","detail":"{read_only:false; response_revision:20067; number_of_response:1; }","duration":"156.867879ms","start":"2026-06-09T23:03:48.471644Z","end":"2026-06-09T23:03:48.628512Z","steps":["trace[1048700193] 'process raft request' (duration: 155.882231ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.628859Z","caller":"traceutil/trace.go:171","msg":"trace[1365304887] transaction","detail":"{read_only:false; response_revision:20068; number_of_response:1; }","duration":"148.712904ms","start":"2026-06-09T23:03:48.480094Z","end":"2026-06-09T23:03:48.628807Z","steps":["trace[1365304887] 'process raft request' (duration: 148.363787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.763371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.984126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18260"} {"level":"info","ts":"2026-06-09T23:03:48.763494Z","caller":"traceutil/trace.go:171","msg":"trace[735753938] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20068; }","duration":"130.1559ms","start":"2026-06-09T23:03:48.633322Z","end":"2026-06-09T23:03:48.763478Z","steps":["trace[735753938] 'range keys from in-memory index tree' (duration: 129.817643ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.7972Z","caller":"traceutil/trace.go:171","msg":"trace[1135530854] transaction","detail":"{read_only:false; response_revision:20070; number_of_response:1; }","duration":"125.328188ms","start":"2026-06-09T23:03:48.671846Z","end":"2026-06-09T23:03:48.797175Z","steps":["trace[1135530854] 'process raft request' (duration: 125.249506ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:48.797408Z","caller":"traceutil/trace.go:171","msg":"trace[1986871204] transaction","detail":"{read_only:false; response_revision:20069; number_of_response:1; }","duration":"138.04315ms","start":"2026-06-09T23:03:48.65934Z","end":"2026-06-09T23:03:48.797383Z","steps":["trace[1986871204] 'process raft request' (duration: 103.39156ms)","trace[1986871204] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:532; } (duration: 32.989969ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:03:48.797522Z","caller":"traceutil/trace.go:171","msg":"trace[996374368] linearizableReadLoop","detail":"{readStateIndex:20745; appliedIndex:20744; }","duration":"129.609769ms","start":"2026-06-09T23:03:48.667902Z","end":"2026-06-09T23:03:48.797512Z","steps":["trace[996374368] 'read index received' (duration: 94.840467ms)","trace[996374368] 'applied index is now lower than readState.Index' (duration: 34.768062ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:03:48.797642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.723761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:03:48.797678Z","caller":"traceutil/trace.go:171","msg":"trace[620328474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20070; }","duration":"129.796093ms","start":"2026-06-09T23:03:48.667875Z","end":"2026-06-09T23:03:48.797671Z","steps":["trace[620328474] 'agreement among raft nodes before linearized reading' (duration: 129.720722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:48.798165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.570373ms","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-09T23:03:48.798263Z","caller":"traceutil/trace.go:171","msg":"trace[1572863726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20070; }","duration":"113.768568ms","start":"2026-06-09T23:03:48.68448Z","end":"2026-06-09T23:03:48.798249Z","steps":["trace[1572863726] 'agreement among raft nodes before linearized reading' (duration: 113.591854ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:49.125099Z","caller":"traceutil/trace.go:171","msg":"trace[338314484] linearizableReadLoop","detail":"{readStateIndex:20747; appliedIndex:20746; }","duration":"299.691631ms","start":"2026-06-09T23:03:48.825382Z","end":"2026-06-09T23:03:49.125074Z","steps":["trace[338314484] 'read index received' (duration: 297.629592ms)","trace[338314484] 'applied index is now lower than readState.Index' (duration: 2.058199ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:03:49.125136Z","caller":"traceutil/trace.go:171","msg":"trace[1516977431] transaction","detail":"{read_only:false; response_revision:20071; number_of_response:1; }","duration":"320.317944ms","start":"2026-06-09T23:03:48.804787Z","end":"2026-06-09T23:03:49.125105Z","steps":["trace[1516977431] 'process raft request' (duration: 318.127172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:49.125305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.778946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:03:49.125351Z","caller":"traceutil/trace.go:171","msg":"trace[1576672267] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:20071; }","duration":"210.884258ms","start":"2026-06-09T23:03:48.914454Z","end":"2026-06-09T23:03:49.125338Z","steps":["trace[1576672267] 'agreement among raft nodes before linearized reading' (duration: 210.787406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:49.12544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:03:48.804764Z","time spent":"320.543317ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:03:49.125395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.961756ms","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-09T23:03:49.125631Z","caller":"traceutil/trace.go:171","msg":"trace[206037770] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20071; }","duration":"300.275921ms","start":"2026-06-09T23:03:48.825343Z","end":"2026-06-09T23:03:49.125619Z","steps":["trace[206037770] 'agreement among raft nodes before linearized reading' (duration: 299.869424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:03:49.125674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:03:48.82533Z","time spent":"300.332223ms","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-09T23:03:49.208246Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17887,"took":"577.78134ms","hash":2497462434,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":30408704,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T23:03:49.20832Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2497462434,"revision":17887,"compact-revision":15346} {"level":"info","ts":"2026-06-09T23:07:32.326029Z","caller":"traceutil/trace.go:171","msg":"trace[833171056] linearizableReadLoop","detail":"{readStateIndex:23220; appliedIndex:23219; }","duration":"169.02688ms","start":"2026-06-09T23:07:32.156974Z","end":"2026-06-09T23:07:32.326Z","steps":["trace[833171056] 'read index received' (duration: 168.710994ms)","trace[833171056] 'applied index is now lower than readState.Index' (duration: 314.706µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:07:32.326198Z","caller":"traceutil/trace.go:171","msg":"trace[2026532703] transaction","detail":"{read_only:false; response_revision:22472; number_of_response:1; }","duration":"176.34414ms","start":"2026-06-09T23:07:32.149801Z","end":"2026-06-09T23:07:32.326145Z","steps":["trace[2026532703] 'process raft request' (duration: 175.920372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:07:32.326377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.23673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-06-09T23:07:32.326384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.386657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"info","ts":"2026-06-09T23:07:32.326426Z","caller":"traceutil/trace.go:171","msg":"trace[1427425688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22472; }","duration":"111.331862ms","start":"2026-06-09T23:07:32.215081Z","end":"2026-06-09T23:07:32.326413Z","steps":["trace[1427425688] 'agreement among raft nodes before linearized reading' (duration: 111.148239ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:07:32.326441Z","caller":"traceutil/trace.go:171","msg":"trace[2094184813] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:22472; }","duration":"169.489759ms","start":"2026-06-09T23:07:32.156935Z","end":"2026-06-09T23:07:32.326425Z","steps":["trace[2094184813] 'agreement among raft nodes before linearized reading' (duration: 169.285685ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:07:32.487591Z","caller":"traceutil/trace.go:171","msg":"trace[1633911869] linearizableReadLoop","detail":"{readStateIndex:23221; appliedIndex:23220; }","duration":"154.29926ms","start":"2026-06-09T23:07:32.333246Z","end":"2026-06-09T23:07:32.487545Z","steps":["trace[1633911869] 'read index received' (duration: 153.655447ms)","trace[1633911869] 'applied index is now lower than readState.Index' (duration: 642.653µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:07:32.487712Z","caller":"traceutil/trace.go:171","msg":"trace[149500392] transaction","detail":"{read_only:false; response_revision:22473; number_of_response:1; }","duration":"155.739288ms","start":"2026-06-09T23:07:32.331884Z","end":"2026-06-09T23:07:32.487623Z","steps":["trace[149500392] 'process raft request' (duration: 155.077035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:07:32.488096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.82655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"} {"level":"info","ts":"2026-06-09T23:07:32.488308Z","caller":"traceutil/trace.go:171","msg":"trace[767494275] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:22473; }","duration":"155.047225ms","start":"2026-06-09T23:07:32.333232Z","end":"2026-06-09T23:07:32.488279Z","steps":["trace[767494275] 'agreement among raft nodes before linearized reading' (duration: 154.542175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:07:32.488173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.926364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:07:32.488639Z","caller":"traceutil/trace.go:171","msg":"trace[1819046419] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:22473; }","duration":"132.394343ms","start":"2026-06-09T23:07:32.356158Z","end":"2026-06-09T23:07:32.488552Z","steps":["trace[1819046419] 'agreement among raft nodes before linearized reading' (duration: 131.835592ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:08:48.632896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20066} {"level":"info","ts":"2026-06-09T23:08:48.736259Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20066,"took":"100.348522ms","hash":205001859,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":41795584,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-06-09T23:08:48.736337Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":205001859,"revision":20066,"compact-revision":17887} {"level":"warn","ts":"2026-06-09T23:10:59.683754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.935224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:59.683838Z","caller":"traceutil/trace.go:171","msg":"trace[2101761260] linearizableReadLoop","detail":"{readStateIndex:25387; appliedIndex:25386; }","duration":"287.539431ms","start":"2026-06-09T23:10:59.396288Z","end":"2026-06-09T23:10:59.683828Z","steps":["trace[2101761260] 'read index received' (duration: 25.24219ms)","trace[2101761260] 'applied index is now lower than readState.Index' (duration: 262.296501ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:59.683869Z","caller":"traceutil/trace.go:171","msg":"trace[780502038] transaction","detail":"{read_only:false; response_revision:24587; number_of_response:1; }","duration":"312.458445ms","start":"2026-06-09T23:10:59.371384Z","end":"2026-06-09T23:10:59.683842Z","steps":["trace[780502038] 'process raft request' (duration: 50.188955ms)","trace[780502038] 'compare' (duration: 261.817342ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:59.683902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.617612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:59.683924Z","caller":"traceutil/trace.go:171","msg":"trace[1984874733] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24587; }","duration":"287.671974ms","start":"2026-06-09T23:10:59.396246Z","end":"2026-06-09T23:10:59.683918Z","steps":["trace[1984874733] 'agreement among raft nodes before linearized reading' (duration: 287.625123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:59.683983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:59.371366Z","time spent":"312.554787ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:59.74915Z","caller":"traceutil/trace.go:171","msg":"trace[1836410451] transaction","detail":"{read_only:false; response_revision:24588; number_of_response:1; }","duration":"171.515224ms","start":"2026-06-09T23:10:59.577392Z","end":"2026-06-09T23:10:59.748907Z","steps":["trace[1836410451] 'process raft request' (duration: 171.335821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:59.972354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.711338ms","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-09T23:10:59.972588Z","caller":"traceutil/trace.go:171","msg":"trace[1126429753] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24588; }","duration":"139.974533ms","start":"2026-06-09T23:10:59.832585Z","end":"2026-06-09T23:10:59.972559Z","steps":["trace[1126429753] 'range keys from in-memory index tree' (duration: 139.682218ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:00.240713Z","caller":"traceutil/trace.go:171","msg":"trace[1335532308] linearizableReadLoop","detail":"{readStateIndex:25389; appliedIndex:25387; }","duration":"556.838857ms","start":"2026-06-09T23:10:59.683852Z","end":"2026-06-09T23:11:00.240691Z","steps":["trace[1335532308] 'read index received' (duration: 64.716482ms)","trace[1335532308] 'applied index is now lower than readState.Index' (duration: 492.121795ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:00.240804Z","caller":"traceutil/trace.go:171","msg":"trace[1056180971] transaction","detail":"{read_only:false; response_revision:24589; number_of_response:1; }","duration":"660.038809ms","start":"2026-06-09T23:10:59.580745Z","end":"2026-06-09T23:11:00.240784Z","steps":["trace[1056180971] 'process raft request' (duration: 657.505541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:00.240876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.592646ms","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-09T23:11:00.240899Z","caller":"traceutil/trace.go:171","msg":"trace[539216206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24589; }","duration":"747.667797ms","start":"2026-06-09T23:10:59.493225Z","end":"2026-06-09T23:11:00.240893Z","steps":["trace[539216206] 'agreement among raft nodes before linearized reading' (duration: 747.541315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:00.240916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:59.493205Z","time spent":"747.706998ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T23:11:00.240903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.086597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-09T23:11:00.240939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:59.580727Z","time spent":"660.136051ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:00.240984Z","caller":"traceutil/trace.go:171","msg":"trace[1461495117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24589; }","duration":"571.21841ms","start":"2026-06-09T23:10:59.669748Z","end":"2026-06-09T23:11:00.240967Z","steps":["trace[1461495117] 'agreement among raft nodes before linearized reading' (duration: 571.055957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:00.241031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:59.669728Z","time spent":"571.295601ms","remote":"127.0.0.1:35166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T23:11:00.426201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.446205ms","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-09T23:11:00.426275Z","caller":"traceutil/trace.go:171","msg":"trace[196119367] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24591; }","duration":"117.552657ms","start":"2026-06-09T23:11:00.308705Z","end":"2026-06-09T23:11:00.426257Z","steps":["trace[196119367] 'range keys from in-memory index tree' (duration: 117.273062ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:00.993709Z","caller":"traceutil/trace.go:171","msg":"trace[1057118334] transaction","detail":"{read_only:false; response_revision:24595; number_of_response:1; }","duration":"339.268146ms","start":"2026-06-09T23:11:00.654419Z","end":"2026-06-09T23:11:00.993687Z","steps":["trace[1057118334] 'process raft request' (duration: 339.156004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:00.993848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:00.654409Z","time spent":"339.364937ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:01.011828Z","caller":"traceutil/trace.go:171","msg":"trace[710567351] linearizableReadLoop","detail":"{readStateIndex:25396; appliedIndex:25395; }","duration":"343.877973ms","start":"2026-06-09T23:11:00.667927Z","end":"2026-06-09T23:11:01.011805Z","steps":["trace[710567351] 'read index received' (duration: 325.777349ms)","trace[710567351] 'applied index is now lower than readState.Index' (duration: 18.099594ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:01.011962Z","caller":"traceutil/trace.go:171","msg":"trace[1297041424] transaction","detail":"{read_only:false; response_revision:24596; number_of_response:1; }","duration":"354.939794ms","start":"2026-06-09T23:11:00.657009Z","end":"2026-06-09T23:11:01.011949Z","steps":["trace[1297041424] 'process raft request' (duration: 354.665979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:01.012083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:00.657Z","time spent":"354.987924ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:01.012186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.540719ms","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-09T23:11:01.012269Z","caller":"traceutil/trace.go:171","msg":"trace[167169048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24596; }","duration":"126.65731ms","start":"2026-06-09T23:11:00.885593Z","end":"2026-06-09T23:11:01.01225Z","steps":["trace[167169048] 'agreement among raft nodes before linearized reading' (duration: 126.458656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:01.01242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.489325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:01.012469Z","caller":"traceutil/trace.go:171","msg":"trace[1886767419] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:24596; }","duration":"344.554656ms","start":"2026-06-09T23:11:00.6679Z","end":"2026-06-09T23:11:01.012454Z","steps":["trace[1886767419] 'agreement among raft nodes before linearized reading' (duration: 344.481015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:01.012552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:00.667892Z","time spent":"344.644349ms","remote":"127.0.0.1:54354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-06-09T23:11:01.012747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.366504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:11:01.012804Z","caller":"traceutil/trace.go:171","msg":"trace[1406765541] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24596; }","duration":"126.474386ms","start":"2026-06-09T23:11:00.886312Z","end":"2026-06-09T23:11:01.012786Z","steps":["trace[1406765541] 'agreement among raft nodes before linearized reading' (duration: 126.301023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:01.281187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.905933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:01.281466Z","caller":"traceutil/trace.go:171","msg":"trace[526159333] transaction","detail":"{read_only:false; response_revision:24598; number_of_response:1; }","duration":"263.171538ms","start":"2026-06-09T23:11:01.018274Z","end":"2026-06-09T23:11:01.281446Z","steps":["trace[526159333] 'process raft request' (duration: 263.022885ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:01.281543Z","caller":"traceutil/trace.go:171","msg":"trace[1616121673] transaction","detail":"{read_only:false; response_revision:24597; number_of_response:1; }","duration":"263.419653ms","start":"2026-06-09T23:11:01.018104Z","end":"2026-06-09T23:11:01.281523Z","steps":["trace[1616121673] 'process raft request' (duration: 134.103903ms)","trace[1616121673] 'compare' (duration: 128.736028ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:01.609777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.867992ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-09T23:11:01.609983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:01.300782Z","time spent":"309.181813ms","remote":"127.0.0.1:35200","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-09T23:11:01.610119Z","caller":"traceutil/trace.go:171","msg":"trace[1271346876] transaction","detail":"{read_only:false; response_revision:24599; number_of_response:1; }","duration":"296.868089ms","start":"2026-06-09T23:11:01.313225Z","end":"2026-06-09T23:11:01.610094Z","steps":["trace[1271346876] 'process raft request' (duration: 296.711756ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:01.610369Z","caller":"traceutil/trace.go:171","msg":"trace[39748669] linearizableReadLoop","detail":"{readStateIndex:25399; appliedIndex:25398; }","duration":"308.089532ms","start":"2026-06-09T23:11:01.302269Z","end":"2026-06-09T23:11:01.610358Z","steps":["trace[39748669] 'read index received' (duration: 116.593669ms)","trace[39748669] 'applied index is now lower than readState.Index' (duration: 191.494713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:01.610583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.303487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-06-09T23:11:01.610613Z","caller":"traceutil/trace.go:171","msg":"trace[2108391759] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24599; }","duration":"308.394448ms","start":"2026-06-09T23:11:01.302209Z","end":"2026-06-09T23:11:01.610603Z","steps":["trace[2108391759] 'agreement among raft nodes before linearized reading' (duration: 308.185894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:01.610644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:01.302183Z","time spent":"308.452589ms","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11859,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"info","ts":"2026-06-09T23:11:01.902303Z","caller":"traceutil/trace.go:171","msg":"trace[522376862] transaction","detail":"{read_only:false; response_revision:24601; number_of_response:1; }","duration":"214.013252ms","start":"2026-06-09T23:11:01.688267Z","end":"2026-06-09T23:11:01.90228Z","steps":["trace[522376862] 'process raft request' (duration: 213.846749ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:01.959608Z","caller":"traceutil/trace.go:171","msg":"trace[1730558247] transaction","detail":"{read_only:false; response_revision:24602; number_of_response:1; }","duration":"204.888659ms","start":"2026-06-09T23:11:01.754682Z","end":"2026-06-09T23:11:01.95957Z","steps":["trace[1730558247] 'process raft request' (duration: 204.748256ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:02.487329Z","caller":"traceutil/trace.go:171","msg":"trace[210386000] transaction","detail":"{read_only:false; response_revision:24605; number_of_response:1; }","duration":"153.46925ms","start":"2026-06-09T23:11:02.333829Z","end":"2026-06-09T23:11:02.487298Z","steps":["trace[210386000] 'process raft request' (duration: 153.283647ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:02.540963Z","caller":"traceutil/trace.go:171","msg":"trace[338181993] transaction","detail":"{read_only:false; response_revision:24606; number_of_response:1; }","duration":"108.660368ms","start":"2026-06-09T23:11:02.432277Z","end":"2026-06-09T23:11:02.540937Z","steps":["trace[338181993] 'process raft request' (duration: 108.066817ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:02.541154Z","caller":"traceutil/trace.go:171","msg":"trace[1430956439] transaction","detail":"{read_only:false; response_revision:24607; number_of_response:1; }","duration":"107.793841ms","start":"2026-06-09T23:11:02.433348Z","end":"2026-06-09T23:11:02.541142Z","steps":["trace[1430956439] 'process raft request' (duration: 107.106038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:02.857048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.935938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:02.857155Z","caller":"traceutil/trace.go:171","msg":"trace[233677372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24607; }","duration":"186.100741ms","start":"2026-06-09T23:11:02.67103Z","end":"2026-06-09T23:11:02.857131Z","steps":["trace[233677372] 'range keys from in-memory index tree' (duration: 185.849587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:02.857336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.836572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:11:02.857416Z","caller":"traceutil/trace.go:171","msg":"trace[1808962500] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:24607; }","duration":"262.936674ms","start":"2026-06-09T23:11:02.594458Z","end":"2026-06-09T23:11:02.857395Z","steps":["trace[1808962500] 'count revisions from in-memory index tree' (duration: 262.75533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:02.857496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.219906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-09T23:11:02.857492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.730629ms","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-09T23:11:02.85757Z","caller":"traceutil/trace.go:171","msg":"trace[1530237737] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24607; }","duration":"256.330047ms","start":"2026-06-09T23:11:02.601224Z","end":"2026-06-09T23:11:02.857554Z","steps":["trace[1530237737] 'range keys from in-memory index tree' (duration: 256.053813ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:02.857586Z","caller":"traceutil/trace.go:171","msg":"trace[1673451236] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24607; }","duration":"221.873582ms","start":"2026-06-09T23:11:02.63569Z","end":"2026-06-09T23:11:02.857563Z","steps":["trace[1673451236] 'range keys from in-memory index tree' (duration: 221.525926ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:02.868229Z","caller":"traceutil/trace.go:171","msg":"trace[642776959] transaction","detail":"{read_only:false; response_revision:24608; number_of_response:1; }","duration":"170.608467ms","start":"2026-06-09T23:11:02.697605Z","end":"2026-06-09T23:11:02.868214Z","steps":["trace[642776959] 'process raft request' (duration: 170.486034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.140157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.304551ms","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-09T23:11:03.140222Z","caller":"traceutil/trace.go:171","msg":"trace[496970555] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24610; }","duration":"181.440983ms","start":"2026-06-09T23:11:02.958767Z","end":"2026-06-09T23:11:03.140208Z","steps":["trace[496970555] 'range keys from in-memory index tree' (duration: 181.147408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.140582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.743057ms","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-09T23:11:03.140608Z","caller":"traceutil/trace.go:171","msg":"trace[2079892467] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24610; }","duration":"142.766477ms","start":"2026-06-09T23:11:02.997834Z","end":"2026-06-09T23:11:03.1406Z","steps":["trace[2079892467] 'range keys from in-memory index tree' (duration: 142.627714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.140785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.243664ms","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-09T23:11:03.140805Z","caller":"traceutil/trace.go:171","msg":"trace[1465404746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24610; }","duration":"124.319426ms","start":"2026-06-09T23:11:03.016481Z","end":"2026-06-09T23:11:03.1408Z","steps":["trace[1465404746] 'range keys from in-memory index tree' (duration: 124.121082ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:03.487955Z","caller":"traceutil/trace.go:171","msg":"trace[822042711] transaction","detail":"{read_only:false; response_revision:24611; number_of_response:1; }","duration":"341.896686ms","start":"2026-06-09T23:11:03.145815Z","end":"2026-06-09T23:11:03.487712Z","steps":["trace[822042711] 'process raft request' (duration: 341.733373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.488111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:03.145791Z","time spent":"342.242082ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:03.527268Z","caller":"traceutil/trace.go:171","msg":"trace[989055890] linearizableReadLoop","detail":"{readStateIndex:25413; appliedIndex:25411; }","duration":"373.013488ms","start":"2026-06-09T23:11:03.15422Z","end":"2026-06-09T23:11:03.527233Z","steps":["trace[989055890] 'read index received' (duration: 333.266492ms)","trace[989055890] 'applied index is now lower than readState.Index' (duration: 39.745876ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:03.527302Z","caller":"traceutil/trace.go:171","msg":"trace[2079119012] transaction","detail":"{read_only:false; response_revision:24612; number_of_response:1; }","duration":"379.386189ms","start":"2026-06-09T23:11:03.147874Z","end":"2026-06-09T23:11:03.52726Z","steps":["trace[2079119012] 'process raft request' (duration: 379.215915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.527557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.311134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"warn","ts":"2026-06-09T23:11:03.52758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:03.147862Z","time spent":"379.518202ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:03.527607Z","caller":"traceutil/trace.go:171","msg":"trace[2058787237] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24612; }","duration":"373.382495ms","start":"2026-06-09T23:11:03.154209Z","end":"2026-06-09T23:11:03.527591Z","steps":["trace[2058787237] 'agreement among raft nodes before linearized reading' (duration: 373.165061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.527645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:03.154204Z","time spent":"373.433146ms","remote":"127.0.0.1:40564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5706,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-09T23:11:03.527935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.520735ms","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-09T23:11:03.527972Z","caller":"traceutil/trace.go:171","msg":"trace[1143888752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24612; }","duration":"242.569216ms","start":"2026-06-09T23:11:03.285394Z","end":"2026-06-09T23:11:03.527963Z","steps":["trace[1143888752] 'agreement among raft nodes before linearized reading' (duration: 242.473104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.528167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.928134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:11:03.528203Z","caller":"traceutil/trace.go:171","msg":"trace[510642459] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24612; }","duration":"241.972125ms","start":"2026-06-09T23:11:03.286222Z","end":"2026-06-09T23:11:03.528194Z","steps":["trace[510642459] 'agreement among raft nodes before linearized reading' (duration: 241.884433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.931522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.2579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:03.931763Z","caller":"traceutil/trace.go:171","msg":"trace[401593419] linearizableReadLoop","detail":"{readStateIndex:25416; appliedIndex:25413; }","duration":"259.704602ms","start":"2026-06-09T23:11:03.672041Z","end":"2026-06-09T23:11:03.931746Z","steps":["trace[401593419] 'read index received' (duration: 59.041µs)","trace[401593419] 'applied index is now lower than readState.Index' (duration: 259.644451ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:03.931854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.816474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:03.93188Z","caller":"traceutil/trace.go:171","msg":"trace[1601541375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24615; }","duration":"259.900955ms","start":"2026-06-09T23:11:03.671972Z","end":"2026-06-09T23:11:03.931873Z","steps":["trace[1601541375] 'agreement among raft nodes before linearized reading' (duration: 259.823284ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:03.932041Z","caller":"traceutil/trace.go:171","msg":"trace[966625303] transaction","detail":"{read_only:false; response_revision:24613; number_of_response:1; }","duration":"400.178975ms","start":"2026-06-09T23:11:03.531831Z","end":"2026-06-09T23:11:03.93201Z","steps":["trace[966625303] 'process raft request' (duration: 126.346164ms)","trace[966625303] 'compare' (duration: 272.607157ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:03.932229Z","caller":"traceutil/trace.go:171","msg":"trace[331949824] transaction","detail":"{read_only:false; response_revision:24614; number_of_response:1; }","duration":"399.441221ms","start":"2026-06-09T23:11:03.532772Z","end":"2026-06-09T23:11:03.932213Z","steps":["trace[331949824] 'process raft request' (duration: 398.85478ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:03.932035Z","caller":"traceutil/trace.go:171","msg":"trace[412548105] transaction","detail":"{read_only:false; response_revision:24615; number_of_response:1; }","duration":"315.066956ms","start":"2026-06-09T23:11:03.616945Z","end":"2026-06-09T23:11:03.932012Z","steps":["trace[412548105] 'process raft request' (duration: 314.76786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:03.932328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:03.532755Z","time spent":"399.511183ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:03.93229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:03.531813Z","time spent":"400.423579ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:03.93246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:03.616912Z","time spent":"315.444812ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:04.260905Z","caller":"traceutil/trace.go:171","msg":"trace[1081640113] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"288.250544ms","start":"2026-06-09T23:11:03.97263Z","end":"2026-06-09T23:11:04.260881Z","steps":["trace[1081640113] 'process raft request' (duration: 271.475315ms)","trace[1081640113] 'compare' (duration: 15.875313ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:04.51396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.521275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:04.514187Z","caller":"traceutil/trace.go:171","msg":"trace[186401055] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"202.901551ms","start":"2026-06-09T23:11:04.311235Z","end":"2026-06-09T23:11:04.514137Z","steps":["trace[186401055] 'process raft request' (duration: 94.106901ms)","trace[186401055] 'compare' (duration: 108.112477ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:04.514221Z","caller":"traceutil/trace.go:171","msg":"trace[95061925] transaction","detail":"{read_only:false; response_revision:24619; number_of_response:1; }","duration":"183.074224ms","start":"2026-06-09T23:11:04.33111Z","end":"2026-06-09T23:11:04.514185Z","steps":["trace[95061925] 'process raft request' (duration: 182.949992ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:04.793071Z","caller":"traceutil/trace.go:171","msg":"trace[1923963476] transaction","detail":"{read_only:false; response_revision:24621; number_of_response:1; }","duration":"243.483313ms","start":"2026-06-09T23:11:04.549561Z","end":"2026-06-09T23:11:04.793045Z","steps":["trace[1923963476] 'process raft request' (duration: 243.28674ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:04.793286Z","caller":"traceutil/trace.go:171","msg":"trace[476543049] transaction","detail":"{read_only:false; response_revision:24622; number_of_response:1; }","duration":"243.30769ms","start":"2026-06-09T23:11:04.549946Z","end":"2026-06-09T23:11:04.793254Z","steps":["trace[476543049] 'process raft request' (duration: 243.060656ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:05.5719Z","caller":"traceutil/trace.go:171","msg":"trace[983560125] linearizableReadLoop","detail":"{readStateIndex:25425; appliedIndex:25424; }","duration":"120.911941ms","start":"2026-06-09T23:11:05.450962Z","end":"2026-06-09T23:11:05.571874Z","steps":["trace[983560125] 'read index received' (duration: 120.626135ms)","trace[983560125] 'applied index is now lower than readState.Index' (duration: 285.056µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:05.572315Z","caller":"traceutil/trace.go:171","msg":"trace[1122351382] transaction","detail":"{read_only:false; response_revision:24624; number_of_response:1; }","duration":"141.154316ms","start":"2026-06-09T23:11:05.431148Z","end":"2026-06-09T23:11:05.572303Z","steps":["trace[1122351382] 'process raft request' (duration: 140.536014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:05.572579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.593773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:05.572618Z","caller":"traceutil/trace.go:171","msg":"trace[2100011119] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:24624; }","duration":"121.711235ms","start":"2026-06-09T23:11:05.450894Z","end":"2026-06-09T23:11:05.572605Z","steps":["trace[2100011119] 'agreement among raft nodes before linearized reading' (duration: 121.618304ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:05.870267Z","caller":"traceutil/trace.go:171","msg":"trace[1861211569] transaction","detail":"{read_only:false; response_revision:24625; number_of_response:1; }","duration":"293.504036ms","start":"2026-06-09T23:11:05.576737Z","end":"2026-06-09T23:11:05.870241Z","steps":["trace[1861211569] 'process raft request' (duration: 270.772823ms)","trace[1861211569] 'compare' (duration: 22.508019ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:06.038593Z","caller":"traceutil/trace.go:171","msg":"trace[1896325886] transaction","detail":"{read_only:false; response_revision:24627; number_of_response:1; }","duration":"100.823129ms","start":"2026-06-09T23:11:05.937747Z","end":"2026-06-09T23:11:06.03857Z","steps":["trace[1896325886] 'process raft request' (duration: 100.770728ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:06.03884Z","caller":"traceutil/trace.go:171","msg":"trace[626247355] transaction","detail":"{read_only:false; response_revision:24626; number_of_response:1; }","duration":"461.94284ms","start":"2026-06-09T23:11:05.57687Z","end":"2026-06-09T23:11:06.038813Z","steps":["trace[626247355] 'process raft request' (duration: 400.503051ms)","trace[626247355] 'compare' (duration: 61.007531ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:06.038859Z","caller":"traceutil/trace.go:171","msg":"trace[2136546780] linearizableReadLoop","detail":"{readStateIndex:25427; appliedIndex:25425; }","duration":"424.236454ms","start":"2026-06-09T23:11:05.614597Z","end":"2026-06-09T23:11:06.038834Z","steps":["trace[2136546780] 'read index received' (duration: 232.923274ms)","trace[2136546780] 'applied index is now lower than readState.Index' (duration: 191.31054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:06.039045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.440367ms","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-09T23:11:06.039071Z","caller":"traceutil/trace.go:171","msg":"trace[288397263] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24627; }","duration":"424.528079ms","start":"2026-06-09T23:11:05.614535Z","end":"2026-06-09T23:11:06.039063Z","steps":["trace[288397263] 'agreement among raft nodes before linearized reading' (duration: 424.397866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:06.039095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:05.614511Z","time spent":"424.579369ms","remote":"127.0.0.1:35288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":379,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-06-09T23:11:06.039236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:05.576862Z","time spent":"462.027162ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:06.193144Z","caller":"traceutil/trace.go:171","msg":"trace[1412317723] linearizableReadLoop","detail":"{readStateIndex:25429; appliedIndex:25428; }","duration":"154.213475ms","start":"2026-06-09T23:11:06.038908Z","end":"2026-06-09T23:11:06.193122Z","steps":["trace[1412317723] 'read index received' (duration: 153.95269ms)","trace[1412317723] 'applied index is now lower than readState.Index' (duration: 259.954µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:06.193502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.509269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:06.193565Z","caller":"traceutil/trace.go:171","msg":"trace[1108687352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24628; }","duration":"526.586851ms","start":"2026-06-09T23:11:05.666964Z","end":"2026-06-09T23:11:06.193551Z","steps":["trace[1108687352] 'agreement among raft nodes before linearized reading' (duration: 526.252574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:06.193791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:05.666901Z","time spent":"526.772384ms","remote":"127.0.0.1:35166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T23:11:06.194157Z","caller":"traceutil/trace.go:171","msg":"trace[284852118] transaction","detail":"{read_only:false; response_revision:24628; number_of_response:1; }","duration":"201.350942ms","start":"2026-06-09T23:11:05.992793Z","end":"2026-06-09T23:11:06.194144Z","steps":["trace[284852118] 'process raft request' (duration: 200.131439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:06.194397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.219203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:11:06.194437Z","caller":"traceutil/trace.go:171","msg":"trace[1001624484] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24628; }","duration":"258.273984ms","start":"2026-06-09T23:11:05.936152Z","end":"2026-06-09T23:11:06.194426Z","steps":["trace[1001624484] 'agreement among raft nodes before linearized reading' (duration: 258.152752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:06.194651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.51549ms","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-09T23:11:06.194686Z","caller":"traceutil/trace.go:171","msg":"trace[1556880020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24628; }","duration":"258.586942ms","start":"2026-06-09T23:11:05.936091Z","end":"2026-06-09T23:11:06.194678Z","steps":["trace[1556880020] 'agreement among raft nodes before linearized reading' (duration: 258.49954ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:06.316783Z","caller":"traceutil/trace.go:171","msg":"trace[183770839] transaction","detail":"{read_only:false; response_revision:24630; number_of_response:1; }","duration":"114.811515ms","start":"2026-06-09T23:11:06.201952Z","end":"2026-06-09T23:11:06.316764Z","steps":["trace[183770839] 'process raft request' (duration: 114.445458ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:06.318127Z","caller":"traceutil/trace.go:171","msg":"trace[358184283] transaction","detail":"{read_only:false; response_revision:24629; number_of_response:1; }","duration":"117.903354ms","start":"2026-06-09T23:11:06.198628Z","end":"2026-06-09T23:11:06.316531Z","steps":["trace[358184283] 'process raft request' (duration: 112.686944ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:14.860939Z","caller":"traceutil/trace.go:171","msg":"trace[1092805880] transaction","detail":"{read_only:false; response_revision:24694; number_of_response:1; }","duration":"292.648689ms","start":"2026-06-09T23:11:14.568269Z","end":"2026-06-09T23:11:14.860918Z","steps":["trace[1092805880] 'process raft request' (duration: 292.496806ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:15.056846Z","caller":"traceutil/trace.go:171","msg":"trace[1776943702] transaction","detail":"{read_only:false; response_revision:24695; number_of_response:1; }","duration":"487.565597ms","start":"2026-06-09T23:11:14.569257Z","end":"2026-06-09T23:11:15.056823Z","steps":["trace[1776943702] 'process raft request' (duration: 485.62292ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:15.057115Z","caller":"traceutil/trace.go:171","msg":"trace[1609780145] linearizableReadLoop","detail":"{readStateIndex:25498; appliedIndex:25496; }","duration":"441.924009ms","start":"2026-06-09T23:11:14.615167Z","end":"2026-06-09T23:11:15.057091Z","steps":["trace[1609780145] 'read index received' (duration: 245.722646ms)","trace[1609780145] 'applied index is now lower than readState.Index' (duration: 196.199973ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:15.057135Z","caller":"traceutil/trace.go:171","msg":"trace[1485811383] transaction","detail":"{read_only:false; response_revision:24696; number_of_response:1; }","duration":"217.502448ms","start":"2026-06-09T23:11:14.839604Z","end":"2026-06-09T23:11:15.057106Z","steps":["trace[1485811383] 'process raft request' (duration: 217.168171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:15.05727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.43709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:15.057307Z","caller":"traceutil/trace.go:171","msg":"trace[877518576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24697; }","duration":"389.519092ms","start":"2026-06-09T23:11:14.667775Z","end":"2026-06-09T23:11:15.057294Z","steps":["trace[877518576] 'agreement among raft nodes before linearized reading' (duration: 389.441191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:15.057337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:14.667755Z","time spent":"389.574193ms","remote":"127.0.0.1:35166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T23:11:15.057238Z","caller":"traceutil/trace.go:171","msg":"trace[1065642322] transaction","detail":"{read_only:false; response_revision:24697; number_of_response:1; }","duration":"217.424396ms","start":"2026-06-09T23:11:14.839705Z","end":"2026-06-09T23:11:15.05713Z","steps":["trace[1065642322] 'process raft request' (duration: 217.276513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:15.057353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.162164ms","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-09T23:11:15.057441Z","caller":"traceutil/trace.go:171","msg":"trace[1710662036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24697; }","duration":"442.285987ms","start":"2026-06-09T23:11:14.615132Z","end":"2026-06-09T23:11:15.057418Z","steps":["trace[1710662036] 'agreement among raft nodes before linearized reading' (duration: 442.065522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:15.05748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:14.615116Z","time spent":"442.355588ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T23:11:15.057524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:14.569225Z","time spent":"487.764472ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:15.378396Z","caller":"traceutil/trace.go:171","msg":"trace[969731452] transaction","detail":"{read_only:false; response_revision:24698; number_of_response:1; }","duration":"315.970532ms","start":"2026-06-09T23:11:15.062394Z","end":"2026-06-09T23:11:15.378364Z","steps":["trace[969731452] 'process raft request' (duration: 273.615397ms)","trace[969731452] 'compare' (duration: 42.172932ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:15.378611Z","caller":"traceutil/trace.go:171","msg":"trace[668363289] transaction","detail":"{read_only:false; response_revision:24699; number_of_response:1; }","duration":"316.046025ms","start":"2026-06-09T23:11:15.062538Z","end":"2026-06-09T23:11:15.378584Z","steps":["trace[668363289] 'process raft request' (duration: 315.7814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:15.37875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:15.062505Z","time spent":"316.167986ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:15.378746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:15.062364Z","time spent":"316.108985ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:15.949075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.870547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:15.94915Z","caller":"traceutil/trace.go:171","msg":"trace[230635419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24699; }","duration":"278.972719ms","start":"2026-06-09T23:11:15.67016Z","end":"2026-06-09T23:11:15.949133Z","steps":["trace[230635419] 'range keys from in-memory index tree' (duration: 278.805416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:15.949127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.472559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:15.94921Z","caller":"traceutil/trace.go:171","msg":"trace[224389526] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:24699; }","duration":"288.609992ms","start":"2026-06-09T23:11:15.660577Z","end":"2026-06-09T23:11:15.949187Z","steps":["trace[224389526] 'count revisions from in-memory index tree' (duration: 288.345257ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:16.098493Z","caller":"traceutil/trace.go:171","msg":"trace[600510934] transaction","detail":"{read_only:false; response_revision:24700; number_of_response:1; }","duration":"144.618762ms","start":"2026-06-09T23:11:15.953836Z","end":"2026-06-09T23:11:16.098455Z","steps":["trace[600510934] 'process raft request' (duration: 144.369747ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:16.646485Z","caller":"traceutil/trace.go:171","msg":"trace[821493158] linearizableReadLoop","detail":"{readStateIndex:25507; appliedIndex:25506; }","duration":"280.821153ms","start":"2026-06-09T23:11:16.365637Z","end":"2026-06-09T23:11:16.646458Z","steps":["trace[821493158] 'read index received' (duration: 280.568918ms)","trace[821493158] 'applied index is now lower than readState.Index' (duration: 251.015µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:16.646557Z","caller":"traceutil/trace.go:171","msg":"trace[1586678681] transaction","detail":"{read_only:false; response_revision:24704; number_of_response:1; }","duration":"296.142796ms","start":"2026-06-09T23:11:16.350395Z","end":"2026-06-09T23:11:16.646538Z","steps":["trace[1586678681] 'process raft request' (duration: 295.88583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:16.646747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.097309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:11:16.646791Z","caller":"traceutil/trace.go:171","msg":"trace[2105018164] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24704; }","duration":"281.188111ms","start":"2026-06-09T23:11:16.365591Z","end":"2026-06-09T23:11:16.646779Z","steps":["trace[2105018164] 'agreement among raft nodes before linearized reading' (duration: 281.024868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:16.646836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.863346ms","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-09T23:11:16.646909Z","caller":"traceutil/trace.go:171","msg":"trace[2064523948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24704; }","duration":"279.000789ms","start":"2026-06-09T23:11:16.36789Z","end":"2026-06-09T23:11:16.646891Z","steps":["trace[2064523948] 'agreement among raft nodes before linearized reading' (duration: 278.773045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:22.842227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.595811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:22.842325Z","caller":"traceutil/trace.go:171","msg":"trace[194674020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24805; }","duration":"175.702193ms","start":"2026-06-09T23:11:22.666602Z","end":"2026-06-09T23:11:22.842304Z","steps":["trace[194674020] 'range keys from in-memory index tree' (duration: 175.513109ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:22.842376Z","caller":"traceutil/trace.go:171","msg":"trace[449226950] linearizableReadLoop","detail":"{readStateIndex:25611; appliedIndex:25610; }","duration":"162.876099ms","start":"2026-06-09T23:11:22.679475Z","end":"2026-06-09T23:11:22.842351Z","steps":["trace[449226950] 'read index received' (duration: 109.081786ms)","trace[449226950] 'applied index is now lower than readState.Index' (duration: 53.793033ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:22.842416Z","caller":"traceutil/trace.go:171","msg":"trace[581792689] transaction","detail":"{read_only:false; response_revision:24806; number_of_response:1; }","duration":"172.808458ms","start":"2026-06-09T23:11:22.669572Z","end":"2026-06-09T23:11:22.84238Z","steps":["trace[581792689] 'process raft request' (duration: 119.009514ms)","trace[581792689] 'compare' (duration: 53.662261ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:22.842629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.141224ms","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-09T23:11:22.842675Z","caller":"traceutil/trace.go:171","msg":"trace[946476090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24806; }","duration":"163.222076ms","start":"2026-06-09T23:11:22.67944Z","end":"2026-06-09T23:11:22.842662Z","steps":["trace[946476090] 'agreement among raft nodes before linearized reading' (duration: 163.062393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:22.842739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.135654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:11:22.84282Z","caller":"traceutil/trace.go:171","msg":"trace[301378726] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24806; }","duration":"163.273946ms","start":"2026-06-09T23:11:22.679522Z","end":"2026-06-09T23:11:22.842796Z","steps":["trace[301378726] 'agreement among raft nodes before linearized reading' (duration: 163.035092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:22.842981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.680108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ad1f9c9-2146-4c0e-b0d9-24a35f98e3a6\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-09T23:11:22.843026Z","caller":"traceutil/trace.go:171","msg":"trace[974184858] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ad1f9c9-2146-4c0e-b0d9-24a35f98e3a6; range_end:; response_count:1; response_revision:24806; }","duration":"159.738399ms","start":"2026-06-09T23:11:22.683274Z","end":"2026-06-09T23:11:22.843012Z","steps":["trace[974184858] 'agreement among raft nodes before linearized reading' (duration: 159.540936ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:23.120293Z","caller":"traceutil/trace.go:171","msg":"trace[894963920] transaction","detail":"{read_only:false; response_revision:24808; number_of_response:1; }","duration":"272.850112ms","start":"2026-06-09T23:11:22.847411Z","end":"2026-06-09T23:11:23.120262Z","steps":["trace[894963920] 'process raft request' (duration: 272.517626ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:23.120337Z","caller":"traceutil/trace.go:171","msg":"trace[1911580286] transaction","detail":"{read_only:false; response_revision:24809; number_of_response:1; }","duration":"233.508883ms","start":"2026-06-09T23:11:22.886784Z","end":"2026-06-09T23:11:23.120293Z","steps":["trace[1911580286] 'process raft request' (duration: 233.36911ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:23.120613Z","caller":"traceutil/trace.go:171","msg":"trace[1862097597] linearizableReadLoop","detail":"{readStateIndex:25613; appliedIndex:25611; }","duration":"258.802985ms","start":"2026-06-09T23:11:22.861779Z","end":"2026-06-09T23:11:23.120582Z","steps":["trace[1862097597] 'read index received' (duration: 48.256778ms)","trace[1862097597] 'applied index is now lower than readState.Index' (duration: 210.545057ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:23.120738Z","caller":"traceutil/trace.go:171","msg":"trace[327378910] transaction","detail":"{read_only:false; response_revision:24810; number_of_response:1; }","duration":"228.07088ms","start":"2026-06-09T23:11:22.892626Z","end":"2026-06-09T23:11:23.120697Z","steps":["trace[327378910] 'process raft request' (duration: 227.58076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:23.12099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.187453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-09T23:11:23.121163Z","caller":"traceutil/trace.go:171","msg":"trace[1939061605] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:24810; }","duration":"259.407927ms","start":"2026-06-09T23:11:22.861739Z","end":"2026-06-09T23:11:23.121147Z","steps":["trace[1939061605] 'agreement among raft nodes before linearized reading' (duration: 259.010049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:23.128831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.194362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:23.128911Z","caller":"traceutil/trace.go:171","msg":"trace[238457779] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:24814; }","duration":"218.327344ms","start":"2026-06-09T23:11:22.910566Z","end":"2026-06-09T23:11:23.128894Z","steps":["trace[238457779] 'agreement among raft nodes before linearized reading' (duration: 218.175211ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:23.585477Z","caller":"traceutil/trace.go:171","msg":"trace[2129647372] transaction","detail":"{read_only:false; response_revision:24816; number_of_response:1; }","duration":"155.829456ms","start":"2026-06-09T23:11:23.429623Z","end":"2026-06-09T23:11:23.585452Z","steps":["trace[2129647372] 'process raft request' (duration: 155.668512ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:23.607202Z","caller":"traceutil/trace.go:171","msg":"trace[451200293] transaction","detail":"{read_only:false; response_revision:24817; number_of_response:1; }","duration":"176.250114ms","start":"2026-06-09T23:11:23.43092Z","end":"2026-06-09T23:11:23.60717Z","steps":["trace[451200293] 'process raft request' (duration: 175.997469ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:23.607311Z","caller":"traceutil/trace.go:171","msg":"trace[1251100008] transaction","detail":"{read_only:false; response_revision:24818; number_of_response:1; }","duration":"174.722035ms","start":"2026-06-09T23:11:23.432564Z","end":"2026-06-09T23:11:23.607286Z","steps":["trace[1251100008] 'process raft request' (duration: 174.536981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:23.794835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.554946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:23.794917Z","caller":"traceutil/trace.go:171","msg":"trace[318033827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24818; }","duration":"127.688719ms","start":"2026-06-09T23:11:23.667209Z","end":"2026-06-09T23:11:23.794898Z","steps":["trace[318033827] 'range keys from in-memory index tree' (duration: 127.448445ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:25.721594Z","caller":"traceutil/trace.go:171","msg":"trace[1940343411] transaction","detail":"{read_only:false; response_revision:24831; number_of_response:1; }","duration":"105.370156ms","start":"2026-06-09T23:11:25.616203Z","end":"2026-06-09T23:11:25.721574Z","steps":["trace[1940343411] 'process raft request' (duration: 105.199683ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:25.746355Z","caller":"traceutil/trace.go:171","msg":"trace[1832989251] transaction","detail":"{read_only:false; response_revision:24832; number_of_response:1; }","duration":"130.095446ms","start":"2026-06-09T23:11:25.61623Z","end":"2026-06-09T23:11:25.746325Z","steps":["trace[1832989251] 'process raft request' (duration: 129.854141ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:28.989111Z","caller":"traceutil/trace.go:171","msg":"trace[458309776] transaction","detail":"{read_only:false; response_revision:24871; number_of_response:1; }","duration":"129.557815ms","start":"2026-06-09T23:11:28.859516Z","end":"2026-06-09T23:11:28.989074Z","steps":["trace[458309776] 'process raft request' (duration: 129.2926ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:29.318772Z","caller":"traceutil/trace.go:171","msg":"trace[1469537042] transaction","detail":"{read_only:false; response_revision:24873; number_of_response:1; }","duration":"173.303758ms","start":"2026-06-09T23:11:29.145449Z","end":"2026-06-09T23:11:29.318753Z","steps":["trace[1469537042] 'process raft request' (duration: 173.182496ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:29.330671Z","caller":"traceutil/trace.go:171","msg":"trace[327414643] transaction","detail":"{read_only:false; response_revision:24875; number_of_response:1; }","duration":"177.326865ms","start":"2026-06-09T23:11:29.153326Z","end":"2026-06-09T23:11:29.330653Z","steps":["trace[327414643] 'process raft request' (duration: 177.235723ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:29.330691Z","caller":"traceutil/trace.go:171","msg":"trace[992322595] transaction","detail":"{read_only:false; response_revision:24876; number_of_response:1; }","duration":"175.613781ms","start":"2026-06-09T23:11:29.15506Z","end":"2026-06-09T23:11:29.330674Z","steps":["trace[992322595] 'process raft request' (duration: 175.54811ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:29.330667Z","caller":"traceutil/trace.go:171","msg":"trace[1885640072] linearizableReadLoop","detail":"{readStateIndex:25682; appliedIndex:25678; }","duration":"172.384159ms","start":"2026-06-09T23:11:29.158261Z","end":"2026-06-09T23:11:29.330645Z","steps":["trace[1885640072] 'read index received' (duration: 160.428452ms)","trace[1885640072] 'applied index is now lower than readState.Index' (duration: 11.954577ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:29.330844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.561844ms","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-09T23:11:29.330892Z","caller":"traceutil/trace.go:171","msg":"trace[1739531268] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24876; }","duration":"172.647525ms","start":"2026-06-09T23:11:29.158233Z","end":"2026-06-09T23:11:29.330881Z","steps":["trace[1739531268] 'agreement among raft nodes before linearized reading' (duration: 172.487742ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:29.33085Z","caller":"traceutil/trace.go:171","msg":"trace[417462452] transaction","detail":"{read_only:false; response_revision:24874; number_of_response:1; }","duration":"181.019964ms","start":"2026-06-09T23:11:29.149761Z","end":"2026-06-09T23:11:29.330781Z","steps":["trace[417462452] 'process raft request' (duration: 180.677038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:29.330906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.004349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:29.331002Z","caller":"traceutil/trace.go:171","msg":"trace[1068246047] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24876; }","duration":"166.128331ms","start":"2026-06-09T23:11:29.164855Z","end":"2026-06-09T23:11:29.330983Z","steps":["trace[1068246047] 'agreement among raft nodes before linearized reading' (duration: 165.975378ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:37.916593Z","caller":"traceutil/trace.go:171","msg":"trace[154104611] linearizableReadLoop","detail":"{readStateIndex:25756; appliedIndex:25755; }","duration":"120.749398ms","start":"2026-06-09T23:11:37.795828Z","end":"2026-06-09T23:11:37.916578Z","steps":["trace[154104611] 'read index received' (duration: 120.573424ms)","trace[154104611] 'applied index is now lower than readState.Index' (duration: 175.374µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:37.916663Z","caller":"traceutil/trace.go:171","msg":"trace[1981544340] transaction","detail":"{read_only:false; response_revision:24948; number_of_response:1; }","duration":"141.344749ms","start":"2026-06-09T23:11:37.775286Z","end":"2026-06-09T23:11:37.916631Z","steps":["trace[1981544340] 'process raft request' (duration: 141.176946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:37.91686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.001322ms","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-09T23:11:37.916951Z","caller":"traceutil/trace.go:171","msg":"trace[1492606317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24948; }","duration":"121.148935ms","start":"2026-06-09T23:11:37.795782Z","end":"2026-06-09T23:11:37.916931Z","steps":["trace[1492606317] 'agreement among raft nodes before linearized reading' (duration: 120.88041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:38.17784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.820531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:38.177926Z","caller":"traceutil/trace.go:171","msg":"trace[1980020559] linearizableReadLoop","detail":"{readStateIndex:25757; appliedIndex:25756; }","duration":"141.86123ms","start":"2026-06-09T23:11:38.036052Z","end":"2026-06-09T23:11:38.177913Z","steps":["trace[1980020559] 'read index received' (duration: 11.921566ms)","trace[1980020559] 'applied index is now lower than readState.Index' (duration: 129.938224ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:38.178043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.974993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:11:38.178116Z","caller":"traceutil/trace.go:171","msg":"trace[1953460059] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:24949; }","duration":"142.085624ms","start":"2026-06-09T23:11:38.036012Z","end":"2026-06-09T23:11:38.178098Z","steps":["trace[1953460059] 'agreement among raft nodes before linearized reading' (duration: 141.948762ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:38.178449Z","caller":"traceutil/trace.go:171","msg":"trace[1109937404] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"253.663137ms","start":"2026-06-09T23:11:37.924763Z","end":"2026-06-09T23:11:38.178427Z","steps":["trace[1109937404] 'process raft request' (duration: 123.182604ms)","trace[1109937404] 'compare' (duration: 129.416222ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:38.259773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.383262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-06-09T23:11:38.259826Z","caller":"traceutil/trace.go:171","msg":"trace[1030903316] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:24951; }","duration":"109.478743ms","start":"2026-06-09T23:11:38.150335Z","end":"2026-06-09T23:11:38.259814Z","steps":["trace[1030903316] 'agreement among raft nodes before linearized reading' (duration: 109.35123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:38.450393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.727398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:38.450661Z","caller":"traceutil/trace.go:171","msg":"trace[1720277892] linearizableReadLoop","detail":"{readStateIndex:25761; appliedIndex:25759; }","duration":"184.794986ms","start":"2026-06-09T23:11:38.265851Z","end":"2026-06-09T23:11:38.450646Z","steps":["trace[1720277892] 'read index received' (duration: 53.733222ms)","trace[1720277892] 'applied index is now lower than readState.Index' (duration: 131.060694ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:38.450628Z","caller":"traceutil/trace.go:171","msg":"trace[1814531537] transaction","detail":"{read_only:false; response_revision:24952; number_of_response:1; }","duration":"187.767333ms","start":"2026-06-09T23:11:38.2628Z","end":"2026-06-09T23:11:38.450568Z","steps":["trace[1814531537] 'process raft request' (duration: 56.7719ms)","trace[1814531537] 'compare' (duration: 130.34092ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:38.450666Z","caller":"traceutil/trace.go:171","msg":"trace[879185618] transaction","detail":"{read_only:false; response_revision:24953; number_of_response:1; }","duration":"186.649262ms","start":"2026-06-09T23:11:38.263954Z","end":"2026-06-09T23:11:38.450603Z","steps":["trace[879185618] 'process raft request' (duration: 186.54317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:38.450759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.902838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-06-09T23:11:38.450782Z","caller":"traceutil/trace.go:171","msg":"trace[5596948] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:24954; }","duration":"184.94016ms","start":"2026-06-09T23:11:38.265835Z","end":"2026-06-09T23:11:38.450775Z","steps":["trace[5596948] 'agreement among raft nodes before linearized reading' (duration: 184.857328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:38.691302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.518563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-09T23:11:38.691388Z","caller":"traceutil/trace.go:171","msg":"trace[535946408] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24954; }","duration":"100.655786ms","start":"2026-06-09T23:11:38.590711Z","end":"2026-06-09T23:11:38.691367Z","steps":["trace[535946408] 'range keys from in-memory index tree' (duration: 100.275289ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:38.797231Z","caller":"traceutil/trace.go:171","msg":"trace[2134824689] transaction","detail":"{read_only:false; response_revision:24955; number_of_response:1; }","duration":"101.772247ms","start":"2026-06-09T23:11:38.695439Z","end":"2026-06-09T23:11:38.797211Z","steps":["trace[2134824689] 'process raft request' (duration: 101.642435ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:39.211976Z","caller":"traceutil/trace.go:171","msg":"trace[1824542218] transaction","detail":"{read_only:false; response_revision:24957; number_of_response:1; }","duration":"122.41589ms","start":"2026-06-09T23:11:39.089526Z","end":"2026-06-09T23:11:39.211942Z","steps":["trace[1824542218] 'process raft request' (duration: 60.131064ms)","trace[1824542218] 'compare' (duration: 61.795227ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:54.533902Z","caller":"traceutil/trace.go:171","msg":"trace[1486997992] transaction","detail":"{read_only:false; response_revision:25087; number_of_response:1; }","duration":"220.406064ms","start":"2026-06-09T23:11:54.313472Z","end":"2026-06-09T23:11:54.533878Z","steps":["trace[1486997992] 'process raft request' (duration: 220.251981ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:54.782237Z","caller":"traceutil/trace.go:171","msg":"trace[1544983679] linearizableReadLoop","detail":"{readStateIndex:25902; appliedIndex:25901; }","duration":"114.746574ms","start":"2026-06-09T23:11:54.667447Z","end":"2026-06-09T23:11:54.782193Z","steps":["trace[1544983679] 'read index received' (duration: 52.52461ms)","trace[1544983679] 'applied index is now lower than readState.Index' (duration: 62.220524ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:54.782385Z","caller":"traceutil/trace.go:171","msg":"trace[1965163622] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"202.240908ms","start":"2026-06-09T23:11:54.580126Z","end":"2026-06-09T23:11:54.782367Z","steps":["trace[1965163622] 'process raft request' (duration: 139.81731ms)","trace[1965163622] 'compare' (duration: 62.110042ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:54.782734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.948137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:54.782808Z","caller":"traceutil/trace.go:171","msg":"trace[1442276635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25090; }","duration":"115.07851ms","start":"2026-06-09T23:11:54.667701Z","end":"2026-06-09T23:11:54.782779Z","steps":["trace[1442276635] 'agreement among raft nodes before linearized reading' (duration: 114.937397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:54.783005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.597489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:54.783075Z","caller":"traceutil/trace.go:171","msg":"trace[71596416] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25090; }","duration":"115.704972ms","start":"2026-06-09T23:11:54.667352Z","end":"2026-06-09T23:11:54.783057Z","steps":["trace[71596416] 'agreement among raft nodes before linearized reading' (duration: 115.455037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:55.059318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.432815ms","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-09T23:11:55.059523Z","caller":"traceutil/trace.go:171","msg":"trace[909529700] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25090; }","duration":"117.708919ms","start":"2026-06-09T23:11:54.941782Z","end":"2026-06-09T23:11:55.059491Z","steps":["trace[909529700] 'range keys from in-memory index tree' (duration: 117.286152ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:55.719992Z","caller":"traceutil/trace.go:171","msg":"trace[186921350] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"288.806657ms","start":"2026-06-09T23:11:55.431159Z","end":"2026-06-09T23:11:55.719966Z","steps":["trace[186921350] 'process raft request' (duration: 288.764776ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:55.720056Z","caller":"traceutil/trace.go:171","msg":"trace[1085888911] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"291.009078ms","start":"2026-06-09T23:11:55.429015Z","end":"2026-06-09T23:11:55.720024Z","steps":["trace[1085888911] 'process raft request' (duration: 290.759542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:56.004363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.728389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:56.004631Z","caller":"traceutil/trace.go:171","msg":"trace[1128766332] linearizableReadLoop","detail":"{readStateIndex:25908; appliedIndex:25904; }","duration":"565.133904ms","start":"2026-06-09T23:11:55.43948Z","end":"2026-06-09T23:11:56.004614Z","steps":["trace[1128766332] 'read index received' (duration: 280.322624ms)","trace[1128766332] 'applied index is now lower than readState.Index' (duration: 284.80997ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:56.004918Z","caller":"traceutil/trace.go:171","msg":"trace[2131557951] transaction","detail":"{read_only:false; response_revision:25095; number_of_response:1; }","duration":"571.451104ms","start":"2026-06-09T23:11:55.433452Z","end":"2026-06-09T23:11:56.004903Z","steps":["trace[2131557951] 'process raft request' (duration: 421.019392ms)","trace[2131557951] 'compare' (duration: 149.105447ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:56.004985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:55.433424Z","time spent":"571.525675ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:56.005183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.680256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:56.005255Z","caller":"traceutil/trace.go:171","msg":"trace[120024766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25096; }","duration":"336.792959ms","start":"2026-06-09T23:11:55.668443Z","end":"2026-06-09T23:11:56.005236Z","steps":["trace[120024766] 'agreement among raft nodes before linearized reading' (duration: 336.650996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:56.005299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:55.668427Z","time spent":"336.8642ms","remote":"127.0.0.1:35166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T23:11:56.005494Z","caller":"traceutil/trace.go:171","msg":"trace[1446249683] transaction","detail":"{read_only:false; response_revision:25096; number_of_response:1; }","duration":"571.209399ms","start":"2026-06-09T23:11:55.434268Z","end":"2026-06-09T23:11:56.005478Z","steps":["trace[1446249683] 'process raft request' (duration: 570.222211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:56.005605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:55.434243Z","time spent":"571.285ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:56.005652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.147815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:11:56.005719Z","caller":"traceutil/trace.go:171","msg":"trace[1984001545] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25096; }","duration":"566.232706ms","start":"2026-06-09T23:11:55.439468Z","end":"2026-06-09T23:11:56.0057Z","steps":["trace[1984001545] 'agreement among raft nodes before linearized reading' (duration: 566.015281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:56.005751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:55.439429Z","time spent":"566.315937ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-09T23:11:56.171865Z","caller":"traceutil/trace.go:171","msg":"trace[188378361] linearizableReadLoop","detail":"{readStateIndex:25909; appliedIndex:25908; }","duration":"152.32642ms","start":"2026-06-09T23:11:56.019518Z","end":"2026-06-09T23:11:56.171844Z","steps":["trace[188378361] 'read index received' (duration: 103.549241ms)","trace[188378361] 'applied index is now lower than readState.Index' (duration: 48.775899ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:56.171926Z","caller":"traceutil/trace.go:171","msg":"trace[1116681169] transaction","detail":"{read_only:false; response_revision:25097; number_of_response:1; }","duration":"162.006083ms","start":"2026-06-09T23:11:56.009885Z","end":"2026-06-09T23:11:56.171891Z","steps":["trace[1116681169] 'process raft request' (duration: 113.296986ms)","trace[1116681169] 'compare' (duration: 48.266379ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:56.172056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.525833ms","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-09T23:11:56.172092Z","caller":"traceutil/trace.go:171","msg":"trace[754293857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25097; }","duration":"152.623455ms","start":"2026-06-09T23:11:56.019458Z","end":"2026-06-09T23:11:56.172081Z","steps":["trace[754293857] 'agreement among raft nodes before linearized reading' (duration: 152.485842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:56.172152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.512264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-09T23:11:56.172209Z","caller":"traceutil/trace.go:171","msg":"trace[1607374808] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25097; }","duration":"150.624847ms","start":"2026-06-09T23:11:56.021568Z","end":"2026-06-09T23:11:56.172193Z","steps":["trace[1607374808] 'agreement among raft nodes before linearized reading' (duration: 150.416253ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:56.310923Z","caller":"traceutil/trace.go:171","msg":"trace[257728481] transaction","detail":"{read_only:false; response_revision:25098; number_of_response:1; }","duration":"134.458539ms","start":"2026-06-09T23:11:56.176429Z","end":"2026-06-09T23:11:56.310887Z","steps":["trace[257728481] 'process raft request' (duration: 133.134654ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:56.310979Z","caller":"traceutil/trace.go:171","msg":"trace[489524335] transaction","detail":"{read_only:false; response_revision:25099; number_of_response:1; }","duration":"134.340187ms","start":"2026-06-09T23:11:56.176615Z","end":"2026-06-09T23:11:56.310955Z","steps":["trace[489524335] 'process raft request' (duration: 134.205443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:57.518522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.393146ms","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-09T23:11:57.518615Z","caller":"traceutil/trace.go:171","msg":"trace[536968904] 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:25105; }","duration":"167.535888ms","start":"2026-06-09T23:11:57.35106Z","end":"2026-06-09T23:11:57.518596Z","steps":["trace[536968904] 'count revisions from in-memory index tree' (duration: 167.313474ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:57.704736Z","caller":"traceutil/trace.go:171","msg":"trace[1268959767] transaction","detail":"{read_only:false; response_revision:25107; number_of_response:1; }","duration":"179.275151ms","start":"2026-06-09T23:11:57.525432Z","end":"2026-06-09T23:11:57.704707Z","steps":["trace[1268959767] 'process raft request' (duration: 131.805568ms)","trace[1268959767] 'compare' (duration: 47.29372ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:09.593967Z","caller":"traceutil/trace.go:171","msg":"trace[1889301043] linearizableReadLoop","detail":"{readStateIndex:26015; appliedIndex:26014; }","duration":"152.570373ms","start":"2026-06-09T23:12:09.441367Z","end":"2026-06-09T23:12:09.593938Z","steps":["trace[1889301043] 'read index received' (duration: 152.332858ms)","trace[1889301043] 'applied index is now lower than readState.Index' (duration: 236.135µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:09.593988Z","caller":"traceutil/trace.go:171","msg":"trace[229403492] transaction","detail":"{read_only:false; response_revision:25200; number_of_response:1; }","duration":"211.054346ms","start":"2026-06-09T23:12:09.38291Z","end":"2026-06-09T23:12:09.593965Z","steps":["trace[229403492] 'process raft request' (duration: 210.860013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:09.594101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.714255ms","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":"info","ts":"2026-06-09T23:12:09.594158Z","caller":"traceutil/trace.go:171","msg":"trace[736254655] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/trunks/; range_end:/registry/openstack.k-orc.cloud/trunks0; response_count:0; response_revision:25200; }","duration":"152.826558ms","start":"2026-06-09T23:12:09.441316Z","end":"2026-06-09T23:12:09.594142Z","steps":["trace[736254655] 'agreement among raft nodes before linearized reading' (duration: 152.720896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:09.933165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.268289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:12:09.933428Z","caller":"traceutil/trace.go:171","msg":"trace[528108224] transaction","detail":"{read_only:false; response_revision:25201; number_of_response:1; }","duration":"293.702219ms","start":"2026-06-09T23:12:09.639704Z","end":"2026-06-09T23:12:09.933406Z","steps":["trace[528108224] 'process raft request' (duration: 70.107824ms)","trace[528108224] 'compare' (duration: 223.165327ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:09.974346Z","caller":"traceutil/trace.go:171","msg":"trace[263782108] transaction","detail":"{read_only:false; response_revision:25202; number_of_response:1; }","duration":"178.66176ms","start":"2026-06-09T23:12:09.795662Z","end":"2026-06-09T23:12:09.974323Z","steps":["trace[263782108] 'process raft request' (duration: 178.541688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:10.187469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.13747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:12:10.187668Z","caller":"traceutil/trace.go:171","msg":"trace[2005087531] transaction","detail":"{read_only:false; response_revision:25203; number_of_response:1; }","duration":"382.016719ms","start":"2026-06-09T23:12:09.80562Z","end":"2026-06-09T23:12:10.187636Z","steps":["trace[2005087531] 'process raft request' (duration: 244.610164ms)","trace[2005087531] 'compare' (duration: 136.969107ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:10.187692Z","caller":"traceutil/trace.go:171","msg":"trace[687899721] transaction","detail":"{read_only:false; response_revision:25204; number_of_response:1; }","duration":"143.230815ms","start":"2026-06-09T23:12:10.044445Z","end":"2026-06-09T23:12:10.187676Z","steps":["trace[687899721] 'process raft request' (duration: 143.143603ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.187755Z","caller":"traceutil/trace.go:171","msg":"trace[1597924321] linearizableReadLoop","detail":"{readStateIndex:26018; appliedIndex:26017; }","duration":"378.621305ms","start":"2026-06-09T23:12:09.809101Z","end":"2026-06-09T23:12:10.187722Z","steps":["trace[1597924321] 'read index received' (duration: 165.212714ms)","trace[1597924321] 'applied index is now lower than readState.Index' (duration: 213.405041ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:12:10.187893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.792478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:12:10.187942Z","caller":"traceutil/trace.go:171","msg":"trace[67382549] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:25204; }","duration":"378.88218ms","start":"2026-06-09T23:12:09.809048Z","end":"2026-06-09T23:12:10.18793Z","steps":["trace[67382549] 'agreement among raft nodes before linearized reading' (duration: 378.775268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:10.187983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:12:09.809026Z","time spent":"378.948051ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":31,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "} {"level":"warn","ts":"2026-06-09T23:12:10.188386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:12:09.805595Z","time spent":"382.163302ms","remote":"127.0.0.1:35464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:12:10.285551Z","caller":"traceutil/trace.go:171","msg":"trace[2123731390] transaction","detail":"{read_only:false; response_revision:25205; number_of_response:1; }","duration":"227.403107ms","start":"2026-06-09T23:12:10.058099Z","end":"2026-06-09T23:12:10.285502Z","steps":["trace[2123731390] 'process raft request' (duration: 226.726134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:10.489751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.350903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-09T23:12:10.489747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.55642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:12:10.489852Z","caller":"traceutil/trace.go:171","msg":"trace[1230545068] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25205; }","duration":"200.516636ms","start":"2026-06-09T23:12:10.289314Z","end":"2026-06-09T23:12:10.489831Z","steps":["trace[1230545068] 'range keys from in-memory index tree' (duration: 200.078557ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.490018Z","caller":"traceutil/trace.go:171","msg":"trace[628430916] transaction","detail":"{read_only:false; response_revision:25206; number_of_response:1; }","duration":"199.278022ms","start":"2026-06-09T23:12:10.290709Z","end":"2026-06-09T23:12:10.489987Z","steps":["trace[628430916] 'process raft request' (duration: 53.365915ms)","trace[628430916] 'compare' (duration: 145.389037ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:10.491Z","caller":"traceutil/trace.go:171","msg":"trace[1805745773] linearizableReadLoop","detail":"{readStateIndex:26022; appliedIndex:26021; }","duration":"113.243324ms","start":"2026-06-09T23:12:10.377739Z","end":"2026-06-09T23:12:10.490982Z","steps":["trace[1805745773] 'read index received' (duration: 113.110162ms)","trace[1805745773] 'applied index is now lower than readState.Index' (duration: 132.302µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:12:10.491243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.512009ms","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-09T23:12:10.491286Z","caller":"traceutil/trace.go:171","msg":"trace[1801935758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25207; }","duration":"113.597641ms","start":"2026-06-09T23:12:10.377676Z","end":"2026-06-09T23:12:10.491273Z","steps":["trace[1801935758] 'agreement among raft nodes before linearized reading' (duration: 113.449448ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.491312Z","caller":"traceutil/trace.go:171","msg":"trace[1695338906] transaction","detail":"{read_only:false; response_revision:25207; number_of_response:1; }","duration":"198.563497ms","start":"2026-06-09T23:12:10.292731Z","end":"2026-06-09T23:12:10.491295Z","steps":["trace[1695338906] 'process raft request' (duration: 198.133459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:10.491459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.203026ms","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-09T23:12:10.491541Z","caller":"traceutil/trace.go:171","msg":"trace[1894341615] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25207; }","duration":"111.349729ms","start":"2026-06-09T23:12:10.38017Z","end":"2026-06-09T23:12:10.49152Z","steps":["trace[1894341615] 'agreement among raft nodes before linearized reading' (duration: 111.065863ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.681529Z","caller":"traceutil/trace.go:171","msg":"trace[222191559] transaction","detail":"{read_only:false; response_revision:25210; number_of_response:1; }","duration":"181.496923ms","start":"2026-06-09T23:12:10.500014Z","end":"2026-06-09T23:12:10.681511Z","steps":["trace[222191559] 'process raft request' (duration: 181.35039ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.68151Z","caller":"traceutil/trace.go:171","msg":"trace[1602552905] transaction","detail":"{read_only:false; response_revision:25209; number_of_response:1; }","duration":"182.030574ms","start":"2026-06-09T23:12:10.499437Z","end":"2026-06-09T23:12:10.681468Z","steps":["trace[1602552905] 'process raft request' (duration: 181.78316ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.68178Z","caller":"traceutil/trace.go:171","msg":"trace[1751764707] transaction","detail":"{read_only:false; response_revision:25211; number_of_response:1; }","duration":"180.936603ms","start":"2026-06-09T23:12:10.500823Z","end":"2026-06-09T23:12:10.68176Z","steps":["trace[1751764707] 'process raft request' (duration: 180.612487ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.681736Z","caller":"traceutil/trace.go:171","msg":"trace[235482161] linearizableReadLoop","detail":"{readStateIndex:26026; appliedIndex:26022; }","duration":"180.31047ms","start":"2026-06-09T23:12:10.501383Z","end":"2026-06-09T23:12:10.681693Z","steps":["trace[235482161] 'read index received' (duration: 2.64318ms)","trace[235482161] 'applied index is now lower than readState.Index' (duration: 177.66331ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:12:10.681992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.586767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:208"} {"level":"info","ts":"2026-06-09T23:12:10.682052Z","caller":"traceutil/trace.go:171","msg":"trace[1374439469] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:25211; }","duration":"180.690579ms","start":"2026-06-09T23:12:10.501346Z","end":"2026-06-09T23:12:10.682036Z","steps":["trace[1374439469] 'agreement among raft nodes before linearized reading' (duration: 180.471764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:10.683731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.592856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418399"} {"level":"info","ts":"2026-06-09T23:12:10.683805Z","caller":"traceutil/trace.go:171","msg":"trace[985767658] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:25213; }","duration":"180.684787ms","start":"2026-06-09T23:12:10.503101Z","end":"2026-06-09T23:12:10.683785Z","steps":["trace[985767658] 'agreement among raft nodes before linearized reading' (duration: 180.393322ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:10.684096Z","caller":"traceutil/trace.go:171","msg":"trace[941630561] transaction","detail":"{read_only:false; response_revision:25212; number_of_response:1; }","duration":"101.269927ms","start":"2026-06-09T23:12:10.582809Z","end":"2026-06-09T23:12:10.684079Z","steps":["trace[941630561] 'process raft request' (duration: 100.484962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:10.684245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.032013ms","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-09T23:12:10.684939Z","caller":"traceutil/trace.go:171","msg":"trace[1918600543] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25213; }","duration":"132.814258ms","start":"2026-06-09T23:12:10.552103Z","end":"2026-06-09T23:12:10.684917Z","steps":["trace[1918600543] 'agreement among raft nodes before linearized reading' (duration: 131.974702ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:15.752392Z","caller":"traceutil/trace.go:171","msg":"trace[1183271578] transaction","detail":"{read_only:false; response_revision:25250; number_of_response:1; }","duration":"131.048163ms","start":"2026-06-09T23:12:15.62133Z","end":"2026-06-09T23:12:15.752379Z","steps":["trace[1183271578] 'process raft request' (duration: 130.89842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:15.950158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.061953ms","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-09T23:12:15.950217Z","caller":"traceutil/trace.go:171","msg":"trace[93963161] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25250; }","duration":"194.168514ms","start":"2026-06-09T23:12:15.756038Z","end":"2026-06-09T23:12:15.950207Z","steps":["trace[93963161] 'range keys from in-memory index tree' (duration: 193.91855ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:16.176059Z","caller":"traceutil/trace.go:171","msg":"trace[2139613195] linearizableReadLoop","detail":"{readStateIndex:26068; appliedIndex:26066; }","duration":"164.924829ms","start":"2026-06-09T23:12:16.011109Z","end":"2026-06-09T23:12:16.176034Z","steps":["trace[2139613195] 'read index received' (duration: 3.829003ms)","trace[2139613195] 'applied index is now lower than readState.Index' (duration: 161.094616ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:16.176104Z","caller":"traceutil/trace.go:171","msg":"trace[1663506951] transaction","detail":"{read_only:false; response_revision:25252; number_of_response:1; }","duration":"182.085935ms","start":"2026-06-09T23:12:15.993972Z","end":"2026-06-09T23:12:16.176058Z","steps":["trace[1663506951] 'process raft request' (duration: 118.562126ms)","trace[1663506951] 'compare' (duration: 63.392477ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:12:16.176184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.072921ms","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-09T23:12:16.176232Z","caller":"traceutil/trace.go:171","msg":"trace[1019333031] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25252; }","duration":"165.175723ms","start":"2026-06-09T23:12:16.011044Z","end":"2026-06-09T23:12:16.176219Z","steps":["trace[1019333031] 'agreement among raft nodes before linearized reading' (duration: 165.086621ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:16.392375Z","caller":"traceutil/trace.go:171","msg":"trace[546362109] transaction","detail":"{read_only:false; response_revision:25253; number_of_response:1; }","duration":"189.357844ms","start":"2026-06-09T23:12:16.202987Z","end":"2026-06-09T23:12:16.392345Z","steps":["trace[546362109] 'process raft request' (duration: 178.1148ms)","trace[546362109] 'compare' (duration: 11.090751ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:16.394693Z","caller":"traceutil/trace.go:171","msg":"trace[1675717404] transaction","detail":"{read_only:false; response_revision:25254; number_of_response:1; }","duration":"188.203741ms","start":"2026-06-09T23:12:16.206475Z","end":"2026-06-09T23:12:16.394679Z","steps":["trace[1675717404] 'process raft request' (duration: 188.083739ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:16.394823Z","caller":"traceutil/trace.go:171","msg":"trace[786800297] linearizableReadLoop","detail":"{readStateIndex:26070; appliedIndex:26068; }","duration":"146.488117ms","start":"2026-06-09T23:12:16.248324Z","end":"2026-06-09T23:12:16.394812Z","steps":["trace[786800297] 'read index received' (duration: 132.827217ms)","trace[786800297] 'applied index is now lower than readState.Index' (duration: 13.65958ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:12:16.395044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.661521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-09T23:12:16.395087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.8166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:12:16.395173Z","caller":"traceutil/trace.go:171","msg":"trace[1981914559] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:25255; }","duration":"119.941182ms","start":"2026-06-09T23:12:16.275215Z","end":"2026-06-09T23:12:16.395157Z","steps":["trace[1981914559] 'agreement among raft nodes before linearized reading' (duration: 119.789279ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:16.395282Z","caller":"traceutil/trace.go:171","msg":"trace[905947095] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25255; }","duration":"146.813703ms","start":"2026-06-09T23:12:16.248301Z","end":"2026-06-09T23:12:16.395115Z","steps":["trace[905947095] 'agreement among raft nodes before linearized reading' (duration: 146.63334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:12:16.649124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.632105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-09T23:12:16.649164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.868682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:12:16.649215Z","caller":"traceutil/trace.go:171","msg":"trace[763819705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25255; }","duration":"121.742147ms","start":"2026-06-09T23:12:16.527449Z","end":"2026-06-09T23:12:16.649191Z","steps":["trace[763819705] 'range keys from in-memory index tree' (duration: 121.448852ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:12:16.649242Z","caller":"traceutil/trace.go:171","msg":"trace[533835912] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25255; }","duration":"128.984474ms","start":"2026-06-09T23:12:16.520233Z","end":"2026-06-09T23:12:16.649218Z","steps":["trace[533835912] 'range keys from in-memory index tree' (duration: 128.657409ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:13:21.18981Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006874.wal"} {"level":"info","ts":"2026-06-09T23:13:48.644089Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23304} {"level":"info","ts":"2026-06-09T23:13:48.780673Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23304,"took":"132.88631ms","hash":1629117795,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":35831808,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-09T23:13:48.780749Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1629117795,"revision":23304,"compact-revision":20066} {"level":"info","ts":"2026-06-09T23:18:48.651539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26159} {"level":"info","ts":"2026-06-09T23:18:48.794556Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26159,"took":"137.014254ms","hash":1354542037,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":34062336,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-09T23:18:48.794637Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1354542037,"revision":26159,"compact-revision":23304} {"level":"info","ts":"2026-06-09T23:19:27.066293Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"19a81b20c4b111c3","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:19:27.071966Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-09T23:19:27.072074Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-09T23:23:48.658039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28802} {"level":"info","ts":"2026-06-09T23:23:48.799908Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28802,"took":"138.465652ms","hash":895702469,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":30138368,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T23:23:48.799978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":895702469,"revision":28802,"compact-revision":26159} {"level":"info","ts":"2026-06-09T23:28:48.664513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31023} {"level":"info","ts":"2026-06-09T23:28:48.789019Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31023,"took":"120.809667ms","hash":2647630914,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":31043584,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-09T23:28:48.789101Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2647630914,"revision":31023,"compact-revision":28802} {"level":"info","ts":"2026-06-09T23:33:48.672608Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33288} {"level":"info","ts":"2026-06-09T23:33:48.833393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33288,"took":"154.336475ms","hash":1923328899,"current-db-size-bytes":59559936,"current-db-size":"60 MB","current-db-size-in-use-bytes":31965184,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-09T23:33:48.833466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1923328899,"revision":33288,"compact-revision":31023} {"level":"info","ts":"2026-06-09T23:38:48.678103Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35580} {"level":"info","ts":"2026-06-09T23:38:48.816717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35580,"took":"132.852785ms","hash":2288735697,"current-db-size-bytes":60444672,"current-db-size":"60 MB","current-db-size-in-use-bytes":31801344,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-09T23:38:48.816794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2288735697,"revision":35580,"compact-revision":33288} {"level":"info","ts":"2026-06-09T23:40:51.717986Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"19a81b20c4b111c3","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:40:51.723217Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-09T23:40:51.723533Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-09T23:43:48.684801Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37810} {"level":"info","ts":"2026-06-09T23:43:48.799717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37810,"took":"110.41674ms","hash":3089234370,"current-db-size-bytes":60444672,"current-db-size":"60 MB","current-db-size-in-use-bytes":30879744,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-09T23:43:48.799803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3089234370,"revision":37810,"compact-revision":35580}