{"level":"warn","ts":"2026-05-18T00:40:10.606661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-18T00:40:10.606809Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-05-18T00:40:10.606894Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-18T00:40:10.606915Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]}
{"level":"info","ts":"2026-05-18T00:40:10.606944Z","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-05-18T00:40:10.60755Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]}
{"level":"info","ts":"2026-05-18T00:40:10.607655Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-05-18T00:40:10.611301Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.370402ms"}
{"level":"info","ts":"2026-05-18T00:40:10.618886Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"}
{"level":"info","ts":"2026-05-18T00:40:10.618976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-18T00:40:10.618997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"}
{"level":"info","ts":"2026-05-18T00:40:10.619012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-18T00:40:10.61903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"}
{"level":"info","ts":"2026-05-18T00:40:10.619074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"}
{"level":"warn","ts":"2026-05-18T00:40:10.623412Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-18T00:40:10.625308Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-18T00:40:10.626728Z","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-05-18T00:40:10.628886Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-18T00:40:10.629153Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-18T00:40:10.629296Z","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-05-18T00:40:10.631297Z","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-05-18T00:40:10.631447Z","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-05-18T00:40:10.634128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"}
{"level":"info","ts":"2026-05-18T00:40:10.63436Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]}
{"level":"info","ts":"2026-05-18T00:40:10.635308Z","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-05-18T00:40:10.635428Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"}
{"level":"info","ts":"2026-05-18T00:40:10.635529Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"}
{"level":"info","ts":"2026-05-18T00:40:10.635599Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-18T00:40:10.635637Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-18T00:40:11.119418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-18T00:40:11.119503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-18T00:40:11.119554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"}
{"level":"info","ts":"2026-05-18T00:40:11.119575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"}
{"level":"info","ts":"2026-05-18T00:40:11.119587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"}
{"level":"info","ts":"2026-05-18T00:40:11.119604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"}
{"level":"info","ts":"2026-05-18T00:40:11.119639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"}
{"level":"info","ts":"2026-05-18T00:40:11.120732Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-18T00:40:11.120773Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T00:40:11.120874Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-18T00:40:11.120946Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-18T00:40:11.121181Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-18T00:40:11.121257Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-18T00:40:11.122217Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T00:40:11.122407Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T00:40:11.122452Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-18T00:40:11.123791Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-18T00:40:11.125566Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"}
{"level":"info","ts":"2026-05-18T00:40:31.059798Z","caller":"traceutil/trace.go:171","msg":"trace[583639148] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"200.921686ms","start":"2026-05-18T00:40:30.858844Z","end":"2026-05-18T00:40:31.059766Z","steps":["trace[583639148] 'process raft request'  (duration: 200.729063ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:31.082261Z","caller":"traceutil/trace.go:171","msg":"trace[1487543994] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:430; }","duration":"107.34411ms","start":"2026-05-18T00:40:30.974885Z","end":"2026-05-18T00:40:31.082229Z","steps":["trace[1487543994] 'read index received'  (duration: 84.742573ms)","trace[1487543994] 'applied index is now lower than readState.Index'  (duration: 22.600106ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:40:31.08231Z","caller":"traceutil/trace.go:171","msg":"trace[1081792425] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"221.979585ms","start":"2026-05-18T00:40:30.860305Z","end":"2026-05-18T00:40:31.082285Z","steps":["trace[1081792425] 'process raft request'  (duration: 221.767571ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:31.082476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.511082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:31.082655Z","caller":"traceutil/trace.go:171","msg":"trace[53187858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"107.722806ms","start":"2026-05-18T00:40:30.974876Z","end":"2026-05-18T00:40:31.082599Z","steps":["trace[53187858] 'agreement among raft nodes before linearized reading'  (duration: 107.480112ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:51.9104Z","caller":"traceutil/trace.go:171","msg":"trace[1144027143] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"216.257992ms","start":"2026-05-18T00:40:51.694103Z","end":"2026-05-18T00:40:51.910361Z","steps":["trace[1144027143] 'read index received'  (duration: 214.190404ms)","trace[1144027143] 'applied index is now lower than readState.Index'  (duration: 2.065878ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:40:51.910428Z","caller":"traceutil/trace.go:171","msg":"trace[1673278958] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"227.594635ms","start":"2026-05-18T00:40:51.682799Z","end":"2026-05-18T00:40:51.910394Z","steps":["trace[1673278958] 'process raft request'  (duration: 225.975797ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.475165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-18T00:40:51.910757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.905321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-18T00:40:51.910761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.226759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.910823Z","caller":"traceutil/trace.go:171","msg":"trace[1875596820] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:588; }","duration":"148.040394ms","start":"2026-05-18T00:40:51.762767Z","end":"2026-05-18T00:40:51.910807Z","steps":["trace[1875596820] 'agreement among raft nodes before linearized reading'  (duration: 147.910151ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:51.91084Z","caller":"traceutil/trace.go:171","msg":"trace[525569677] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"122.386932ms","start":"2026-05-18T00:40:51.788431Z","end":"2026-05-18T00:40:51.910818Z","steps":["trace[525569677] 'agreement among raft nodes before linearized reading'  (duration: 122.242699ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.077489ms","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:5"}
{"level":"info","ts":"2026-05-18T00:40:51.910779Z","caller":"traceutil/trace.go:171","msg":"trace[1427571418] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"216.579087ms","start":"2026-05-18T00:40:51.694182Z","end":"2026-05-18T00:40:51.910761Z","steps":["trace[1427571418] 'agreement among raft nodes before linearized reading'  (duration: 216.461625ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.129965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.910997Z","caller":"traceutil/trace.go:171","msg":"trace[2146499121] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:588; }","duration":"148.196066ms","start":"2026-05-18T00:40:51.762792Z","end":"2026-05-18T00:40:51.910988Z","steps":["trace[2146499121] 'agreement among raft nodes before linearized reading'  (duration: 148.138805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.494976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-18T00:40:51.912154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.846845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.912195Z","caller":"traceutil/trace.go:171","msg":"trace[498404318] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"218.090454ms","start":"2026-05-18T00:40:51.694063Z","end":"2026-05-18T00:40:51.912153Z","steps":["trace[498404318] 'agreement among raft nodes before linearized reading'  (duration: 216.437594ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:51.912279Z","caller":"traceutil/trace.go:171","msg":"trace[63554623] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"102.21194ms","start":"2026-05-18T00:40:51.81002Z","end":"2026-05-18T00:40:51.912232Z","steps":["trace[63554623] 'agreement among raft nodes before linearized reading'  (duration: 100.824004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.325447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.912398Z","caller":"traceutil/trace.go:171","msg":"trace[1919246470] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:588; }","duration":"170.909686ms","start":"2026-05-18T00:40:51.74146Z","end":"2026-05-18T00:40:51.91237Z","steps":["trace[1919246470] 'agreement among raft nodes before linearized reading'  (duration: 169.343778ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.116119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.912928Z","caller":"traceutil/trace.go:171","msg":"trace[1670446606] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:588; }","duration":"197.983933ms","start":"2026-05-18T00:40:51.714865Z","end":"2026-05-18T00:40:51.912848Z","steps":["trace[1670446606] 'agreement among raft nodes before linearized reading'  (duration: 196.108309ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.910907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.268142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-18T00:40:51.913165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.466849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.913287Z","caller":"traceutil/trace.go:171","msg":"trace[220326666] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:588; }","duration":"149.605041ms","start":"2026-05-18T00:40:51.76363Z","end":"2026-05-18T00:40:51.913235Z","steps":["trace[220326666] 'agreement among raft nodes before linearized reading'  (duration: 147.245209ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.913565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.029853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.913628Z","caller":"traceutil/trace.go:171","msg":"trace[1728900369] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:588; }","duration":"198.087924ms","start":"2026-05-18T00:40:51.71551Z","end":"2026-05-18T00:40:51.913598Z","steps":["trace[1728900369] 'agreement among raft nodes before linearized reading'  (duration: 195.441006ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.914145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.34186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.914266Z","caller":"traceutil/trace.go:171","msg":"trace[1918337327] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:588; }","duration":"173.493722ms","start":"2026-05-18T00:40:51.740735Z","end":"2026-05-18T00:40:51.914228Z","steps":["trace[1918337327] 'agreement among raft nodes before linearized reading'  (duration: 170.225512ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:51.914363Z","caller":"traceutil/trace.go:171","msg":"trace[2010805637] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"101.213931ms","start":"2026-05-18T00:40:51.809741Z","end":"2026-05-18T00:40:51.910955Z","steps":["trace[2010805637] 'agreement among raft nodes before linearized reading'  (duration: 100.982747ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.914464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.097709ms","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:5"}
{"level":"warn","ts":"2026-05-18T00:40:51.914561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.639924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.914687Z","caller":"traceutil/trace.go:171","msg":"trace[976145392] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:588; }","duration":"199.838276ms","start":"2026-05-18T00:40:51.714813Z","end":"2026-05-18T00:40:51.914651Z","steps":["trace[976145392] 'agreement among raft nodes before linearized reading'  (duration: 196.139759ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.914862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.334657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.914905Z","caller":"traceutil/trace.go:171","msg":"trace[1697230874] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:588; }","duration":"174.393029ms","start":"2026-05-18T00:40:51.74049Z","end":"2026-05-18T00:40:51.914883Z","steps":["trace[1697230874] 'agreement among raft nodes before linearized reading'  (duration: 170.480708ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:51.914981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.730082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:51.915068Z","caller":"traceutil/trace.go:171","msg":"trace[1627961751] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:588; }","duration":"220.820814ms","start":"2026-05-18T00:40:51.694213Z","end":"2026-05-18T00:40:51.915034Z","steps":["trace[1627961751] 'agreement among raft nodes before linearized reading'  (duration: 216.761751ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:51.914609Z","caller":"traceutil/trace.go:171","msg":"trace[1316590513] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"126.271422ms","start":"2026-05-18T00:40:51.788318Z","end":"2026-05-18T00:40:51.914589Z","steps":["trace[1316590513] 'agreement among raft nodes before linearized reading'  (duration: 122.637066ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:51.915957Z","caller":"traceutil/trace.go:171","msg":"trace[290194579] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:588; }","duration":"103.580833ms","start":"2026-05-18T00:40:51.809598Z","end":"2026-05-18T00:40:51.913179Z","steps":["trace[290194579] 'agreement among raft nodes before linearized reading'  (duration: 101.19536ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:52.143422Z","caller":"traceutil/trace.go:171","msg":"trace[1735748842] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"168.302889ms","start":"2026-05-18T00:40:51.975078Z","end":"2026-05-18T00:40:52.143381Z","steps":["trace[1735748842] 'read index received'  (duration: 86.13218ms)","trace[1735748842] 'applied index is now lower than readState.Index'  (duration: 82.169298ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:40:52.143539Z","caller":"traceutil/trace.go:171","msg":"trace[695919759] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"172.001654ms","start":"2026-05-18T00:40:51.971491Z","end":"2026-05-18T00:40:52.143493Z","steps":["trace[695919759] 'process raft request'  (duration: 89.711954ms)","trace[695919759] 'compare'  (duration: 82.031426ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T00:40:52.143626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.519142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:40:52.14367Z","caller":"traceutil/trace.go:171","msg":"trace[191431529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"168.627404ms","start":"2026-05-18T00:40:51.975029Z","end":"2026-05-18T00:40:52.143656Z","steps":["trace[191431529] 'agreement among raft nodes before linearized reading'  (duration: 168.468002ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:40:52.384686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.642989ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101133354 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:576 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-18T00:40:52.38482Z","caller":"traceutil/trace.go:171","msg":"trace[653970522] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"109.351208ms","start":"2026-05-18T00:40:52.275448Z","end":"2026-05-18T00:40:52.384799Z","steps":["trace[653970522] 'read index received'  (duration: 52.291µs)","trace[653970522] 'applied index is now lower than readState.Index'  (duration: 109.297357ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T00:40:52.38505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.600442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jlr4n\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-18T00:40:52.385188Z","caller":"traceutil/trace.go:171","msg":"trace[810542009] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jlr4n; range_end:; response_count:1; response_revision:590; }","duration":"109.780035ms","start":"2026-05-18T00:40:52.275395Z","end":"2026-05-18T00:40:52.385175Z","steps":["trace[810542009] 'agreement among raft nodes before linearized reading'  (duration: 109.4595ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:52.385441Z","caller":"traceutil/trace.go:171","msg":"trace[745367564] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"165.934175ms","start":"2026-05-18T00:40:52.219458Z","end":"2026-05-18T00:40:52.385392Z","steps":["trace[745367564] 'process raft request'  (duration: 37.84503ms)","trace[745367564] 'compare'  (duration: 126.490996ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:40:52.658541Z","caller":"traceutil/trace.go:171","msg":"trace[172064131] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"254.812445ms","start":"2026-05-18T00:40:52.403691Z","end":"2026-05-18T00:40:52.658503Z","steps":["trace[172064131] 'process raft request'  (duration: 254.073962ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:40:52.776734Z","caller":"traceutil/trace.go:171","msg":"trace[169236220] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"220.507047ms","start":"2026-05-18T00:40:52.556192Z","end":"2026-05-18T00:40:52.776699Z","steps":["trace[169236220] 'process raft request'  (duration: 216.273061ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:42:00.803078Z","caller":"traceutil/trace.go:171","msg":"trace[1670429333] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"109.024993ms","start":"2026-05-18T00:42:00.694025Z","end":"2026-05-18T00:42:00.80305Z","steps":["trace[1670429333] 'process raft request'  (duration: 108.721958ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:42:26.381845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.181597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-18T00:42:26.381969Z","caller":"traceutil/trace.go:171","msg":"trace[1872910081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1819; }","duration":"214.35337ms","start":"2026-05-18T00:42:26.167589Z","end":"2026-05-18T00:42:26.381942Z","steps":["trace[1872910081] 'range keys from in-memory index tree'  (duration: 213.899803ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:42:26.382267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.097504ms","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-05-18T00:42:26.382398Z","caller":"traceutil/trace.go:171","msg":"trace[522589590] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1819; }","duration":"273.289128ms","start":"2026-05-18T00:42:26.109076Z","end":"2026-05-18T00:42:26.382365Z","steps":["trace[522589590] 'range keys from in-memory index tree'  (duration: 272.438283ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:42:26.38229Z","caller":"traceutil/trace.go:171","msg":"trace[1009844224] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"183.137275ms","start":"2026-05-18T00:42:26.199103Z","end":"2026-05-18T00:42:26.38224Z","steps":["trace[1009844224] 'process raft request'  (duration: 150.766919ms)","trace[1009844224] 'compare'  (duration: 32.063671ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:43:16.926302Z","caller":"traceutil/trace.go:171","msg":"trace[537842495] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"177.961429ms","start":"2026-05-18T00:43:16.748303Z","end":"2026-05-18T00:43:16.926264Z","steps":["trace[537842495] 'process raft request'  (duration: 177.745055ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:44:45.350238Z","caller":"traceutil/trace.go:171","msg":"trace[1991675417] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"124.435494ms","start":"2026-05-18T00:44:45.225777Z","end":"2026-05-18T00:44:45.350212Z","steps":["trace[1991675417] 'process raft request'  (duration: 124.275201ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:47:10.636254Z","caller":"traceutil/trace.go:171","msg":"trace[1978331175] transaction","detail":"{read_only:false; response_revision:3787; number_of_response:1; }","duration":"184.658428ms","start":"2026-05-18T00:47:10.451561Z","end":"2026-05-18T00:47:10.636219Z","steps":["trace[1978331175] 'process raft request'  (duration: 168.505039ms)","trace[1978331175] 'compare'  (duration: 16.023446ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T00:48:39.209716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.089208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:48:39.209812Z","caller":"traceutil/trace.go:171","msg":"trace[1868978320] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4975; }","duration":"160.246671ms","start":"2026-05-18T00:48:39.049547Z","end":"2026-05-18T00:48:39.209794Z","steps":["trace[1868978320] 'range keys from in-memory index tree'  (duration: 159.993077ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:48:39.210199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.681008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-18T00:48:39.210269Z","caller":"traceutil/trace.go:171","msg":"trace[69349394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4975; }","duration":"106.749279ms","start":"2026-05-18T00:48:39.103481Z","end":"2026-05-18T00:48:39.210231Z","steps":["trace[69349394] 'range keys from in-memory index tree'  (duration: 106.531475ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:48:50.367826Z","caller":"traceutil/trace.go:171","msg":"trace[1729075111] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"196.171287ms","start":"2026-05-18T00:48:50.171627Z","end":"2026-05-18T00:48:50.367798Z","steps":["trace[1729075111] 'process raft request'  (duration: 195.923433ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:49:01.446969Z","caller":"traceutil/trace.go:171","msg":"trace[437717249] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"159.579229ms","start":"2026-05-18T00:49:01.287355Z","end":"2026-05-18T00:49:01.446935Z","steps":["trace[437717249] 'process raft request'  (duration: 158.469378ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:49:01.447312Z","caller":"traceutil/trace.go:171","msg":"trace[393871820] linearizableReadLoop","detail":"{readStateIndex:5607; appliedIndex:5606; }","duration":"133.667638ms","start":"2026-05-18T00:49:01.313632Z","end":"2026-05-18T00:49:01.4473Z","steps":["trace[393871820] 'read index received'  (duration: 132.280812ms)","trace[393871820] 'applied index is now lower than readState.Index'  (duration: 1.385116ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T00:49:01.447474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.821632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-18T00:49:01.447522Z","caller":"traceutil/trace.go:171","msg":"trace[1536518970] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5410; }","duration":"133.918813ms","start":"2026-05-18T00:49:01.313594Z","end":"2026-05-18T00:49:01.447513Z","steps":["trace[1536518970] 'agreement among raft nodes before linearized reading'  (duration: 133.766781ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:50:11.150258Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961}
{"level":"info","ts":"2026-05-18T00:50:11.227331Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"75.500494ms","hash":4133227219,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":33714176,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-18T00:50:11.227397Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4133227219,"revision":2961,"compact-revision":-1}
{"level":"info","ts":"2026-05-18T00:55:05.805828Z","caller":"traceutil/trace.go:171","msg":"trace[232659193] linearizableReadLoop","detail":"{readStateIndex:8510; appliedIndex:8509; }","duration":"145.270054ms","start":"2026-05-18T00:55:05.66053Z","end":"2026-05-18T00:55:05.8058Z","steps":["trace[232659193] 'read index received'  (duration: 145.084201ms)","trace[232659193] 'applied index is now lower than readState.Index'  (duration: 184.353µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T00:55:05.806091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.544049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-18T00:55:05.806132Z","caller":"traceutil/trace.go:171","msg":"trace[955622161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8217; }","duration":"145.62991ms","start":"2026-05-18T00:55:05.660492Z","end":"2026-05-18T00:55:05.806122Z","steps":["trace[955622161] 'agreement among raft nodes before linearized reading'  (duration: 145.432556ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:05.806522Z","caller":"traceutil/trace.go:171","msg":"trace[1594822422] transaction","detail":"{read_only:false; response_revision:8217; number_of_response:1; }","duration":"146.895943ms","start":"2026-05-18T00:55:05.659601Z","end":"2026-05-18T00:55:05.806497Z","steps":["trace[1594822422] 'process raft request'  (duration: 145.982586ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:06.714349Z","caller":"traceutil/trace.go:171","msg":"trace[217204994] transaction","detail":"{read_only:false; response_revision:8220; number_of_response:1; }","duration":"192.68029ms","start":"2026-05-18T00:55:06.521641Z","end":"2026-05-18T00:55:06.714321Z","steps":["trace[217204994] 'process raft request'  (duration: 192.501156ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:11.162907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6050}
{"level":"info","ts":"2026-05-18T00:55:11.268073Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6050,"took":"103.197727ms","hash":2185485113,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":23064576,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-18T00:55:11.268136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2185485113,"revision":6050,"compact-revision":2961}
{"level":"info","ts":"2026-05-18T00:55:33.643661Z","caller":"traceutil/trace.go:171","msg":"trace[1327656347] transaction","detail":"{read_only:false; response_revision:8415; number_of_response:1; }","duration":"176.396249ms","start":"2026-05-18T00:55:33.467236Z","end":"2026-05-18T00:55:33.643632Z","steps":["trace[1327656347] 'process raft request'  (duration: 176.258326ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:55:33.643807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.386705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-18T00:55:33.643842Z","caller":"traceutil/trace.go:171","msg":"trace[979576369] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8415; }","duration":"153.467486ms","start":"2026-05-18T00:55:33.490367Z","end":"2026-05-18T00:55:33.643835Z","steps":["trace[979576369] 'agreement among raft nodes before linearized reading'  (duration: 153.332533ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:33.643646Z","caller":"traceutil/trace.go:171","msg":"trace[360111041] linearizableReadLoop","detail":"{readStateIndex:8716; appliedIndex:8715; }","duration":"153.205131ms","start":"2026-05-18T00:55:33.490402Z","end":"2026-05-18T00:55:33.643607Z","steps":["trace[360111041] 'read index received'  (duration: 153.088649ms)","trace[360111041] 'applied index is now lower than readState.Index'  (duration: 115.432µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:55:33.789596Z","caller":"traceutil/trace.go:171","msg":"trace[799994784] transaction","detail":"{read_only:false; response_revision:8416; number_of_response:1; }","duration":"195.343369ms","start":"2026-05-18T00:55:33.594231Z","end":"2026-05-18T00:55:33.789575Z","steps":["trace[799994784] 'process raft request'  (duration: 193.26337ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:33.789788Z","caller":"traceutil/trace.go:171","msg":"trace[1602567190] transaction","detail":"{read_only:false; response_revision:8417; number_of_response:1; }","duration":"140.825951ms","start":"2026-05-18T00:55:33.648928Z","end":"2026-05-18T00:55:33.789754Z","steps":["trace[1602567190] 'process raft request'  (duration: 140.610477ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:36.113953Z","caller":"traceutil/trace.go:171","msg":"trace[785855317] transaction","detail":"{read_only:false; response_revision:8430; number_of_response:1; }","duration":"118.211313ms","start":"2026-05-18T00:55:35.995717Z","end":"2026-05-18T00:55:36.113928Z","steps":["trace[785855317] 'process raft request'  (duration: 118.066971ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:36.275923Z","caller":"traceutil/trace.go:171","msg":"trace[1411647539] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"124.191715ms","start":"2026-05-18T00:55:36.1517Z","end":"2026-05-18T00:55:36.275892Z","steps":["trace[1411647539] 'process raft request'  (duration: 66.423097ms)","trace[1411647539] 'compare'  (duration: 57.625375ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:55:46.431869Z","caller":"traceutil/trace.go:171","msg":"trace[1128474324] transaction","detail":"{read_only:false; response_revision:8526; number_of_response:1; }","duration":"109.311189ms","start":"2026-05-18T00:55:46.322487Z","end":"2026-05-18T00:55:46.431798Z","steps":["trace[1128474324] 'process raft request'  (duration: 109.030724ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:47.172688Z","caller":"traceutil/trace.go:171","msg":"trace[1400485518] transaction","detail":"{read_only:false; response_revision:8532; number_of_response:1; }","duration":"113.269962ms","start":"2026-05-18T00:55:47.059384Z","end":"2026-05-18T00:55:47.172654Z","steps":["trace[1400485518] 'process raft request'  (duration: 112.847744ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:47.738589Z","caller":"traceutil/trace.go:171","msg":"trace[690874990] linearizableReadLoop","detail":"{readStateIndex:8841; appliedIndex:8840; }","duration":"136.598023ms","start":"2026-05-18T00:55:47.601966Z","end":"2026-05-18T00:55:47.738564Z","steps":["trace[690874990] 'read index received'  (duration: 130.586202ms)","trace[690874990] 'applied index is now lower than readState.Index'  (duration: 6.010571ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:55:47.738611Z","caller":"traceutil/trace.go:171","msg":"trace[724820818] transaction","detail":"{read_only:false; response_revision:8535; number_of_response:1; }","duration":"171.308284ms","start":"2026-05-18T00:55:47.567281Z","end":"2026-05-18T00:55:47.738589Z","steps":["trace[724820818] 'process raft request'  (duration: 165.298164ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:55:47.73876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.756816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-18T00:55:47.738869Z","caller":"traceutil/trace.go:171","msg":"trace[1988531072] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8535; }","duration":"136.897689ms","start":"2026-05-18T00:55:47.60195Z","end":"2026-05-18T00:55:47.738847Z","steps":["trace[1988531072] 'agreement among raft nodes before linearized reading'  (duration: 136.682334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:55:48.109566Z","caller":"traceutil/trace.go:171","msg":"trace[582529923] linearizableReadLoop","detail":"{readStateIndex:8844; appliedIndex:8843; }","duration":"135.550514ms","start":"2026-05-18T00:55:47.973985Z","end":"2026-05-18T00:55:48.109535Z","steps":["trace[582529923] 'read index received'  (duration: 130.720445ms)","trace[582529923] 'applied index is now lower than readState.Index'  (duration: 4.828389ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:55:48.109696Z","caller":"traceutil/trace.go:171","msg":"trace[1101680032] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"184.435357ms","start":"2026-05-18T00:55:47.925217Z","end":"2026-05-18T00:55:48.109652Z","steps":["trace[1101680032] 'process raft request'  (duration: 179.519426ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:55:48.109825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.780739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T00:55:48.109871Z","caller":"traceutil/trace.go:171","msg":"trace[1385666302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8538; }","duration":"135.926871ms","start":"2026-05-18T00:55:47.973931Z","end":"2026-05-18T00:55:48.109858Z","steps":["trace[1385666302] 'agreement among raft nodes before linearized reading'  (duration: 135.773018ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T00:55:48.110564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.107727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2213919"}
{"level":"info","ts":"2026-05-18T00:55:48.110633Z","caller":"traceutil/trace.go:171","msg":"trace[278709637] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8538; }","duration":"121.240369ms","start":"2026-05-18T00:55:47.989378Z","end":"2026-05-18T00:55:48.110619Z","steps":["trace[278709637] 'agreement among raft nodes before linearized reading'  (duration: 120.453855ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T00:56:31.848346Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002448.wal"}
{"level":"info","ts":"2026-05-18T00:57:46.949453Z","caller":"traceutil/trace.go:171","msg":"trace[1088467460] transaction","detail":"{read_only:false; response_revision:9629; number_of_response:1; }","duration":"100.45266ms","start":"2026-05-18T00:57:46.848936Z","end":"2026-05-18T00:57:46.949388Z","steps":["trace[1088467460] 'process raft request'  (duration: 68.852135ms)","trace[1088467460] 'compare'  (duration: 31.422222ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T00:57:49.792625Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-18T00:57:49.797554Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-18T00:57:49.797648Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-18T01:00:11.171307Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8251}
{"level":"info","ts":"2026-05-18T01:00:11.276165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8251,"took":"102.386476ms","hash":2715112476,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":26660864,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-18T01:00:11.276238Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2715112476,"revision":8251,"compact-revision":6050}
{"level":"warn","ts":"2026-05-18T01:00:42.472145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.426018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19103"}
{"level":"info","ts":"2026-05-18T01:00:42.472305Z","caller":"traceutil/trace.go:171","msg":"trace[824750499] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11141; }","duration":"135.629472ms","start":"2026-05-18T01:00:42.336648Z","end":"2026-05-18T01:00:42.472277Z","steps":["trace[824750499] 'range keys from in-memory index tree'  (duration: 135.162863ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:05:11.177699Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10944}
{"level":"info","ts":"2026-05-18T01:05:11.258674Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10944,"took":"76.701331ms","hash":3768397627,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":28651520,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-18T01:05:11.259074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3768397627,"revision":10944,"compact-revision":8251}
{"level":"warn","ts":"2026-05-18T01:07:03.921456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.623767ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101167470 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/placement.18b08371a373ebaf\" mod_revision:13448 > success:<request_put:<key:\"/registry/events/openstack/placement.18b08371a373ebaf\" value_size:588 lease:6216830301246391221 >> failure:<request_range:<key:\"/registry/events/openstack/placement.18b08371a373ebaf\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-18T01:07:03.921632Z","caller":"traceutil/trace.go:171","msg":"trace[1845713030] transaction","detail":"{read_only:false; response_revision:13741; number_of_response:1; }","duration":"228.083014ms","start":"2026-05-18T01:07:03.693519Z","end":"2026-05-18T01:07:03.921602Z","steps":["trace[1845713030] 'process raft request'  (duration: 82.183122ms)","trace[1845713030] 'compare'  (duration: 145.423923ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:07:03.927664Z","caller":"traceutil/trace.go:171","msg":"trace[493778382] linearizableReadLoop","detail":"{readStateIndex:14216; appliedIndex:14214; }","duration":"212.647818ms","start":"2026-05-18T01:07:03.714878Z","end":"2026-05-18T01:07:03.927526Z","steps":["trace[493778382] 'read index received'  (duration: 60.804316ms)","trace[493778382] 'applied index is now lower than readState.Index'  (duration: 151.841822ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:07:03.927687Z","caller":"traceutil/trace.go:171","msg":"trace[1809721733] transaction","detail":"{read_only:false; response_revision:13742; number_of_response:1; }","duration":"223.084131ms","start":"2026-05-18T01:07:03.704547Z","end":"2026-05-18T01:07:03.927631Z","steps":["trace[1809721733] 'process raft request'  (duration: 222.769875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:07:03.928104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.189668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-18T01:07:03.928174Z","caller":"traceutil/trace.go:171","msg":"trace[1652112918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13742; }","duration":"213.297711ms","start":"2026-05-18T01:07:03.714859Z","end":"2026-05-18T01:07:03.928156Z","steps":["trace[1652112918] 'agreement among raft nodes before linearized reading'  (duration: 212.907284ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:07:03.949288Z","caller":"traceutil/trace.go:171","msg":"trace[1362626117] transaction","detail":"{read_only:false; response_revision:13743; number_of_response:1; }","duration":"163.793984ms","start":"2026-05-18T01:07:03.785462Z","end":"2026-05-18T01:07:03.949256Z","steps":["trace[1362626117] 'process raft request'  (duration: 163.445348ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:07:04.705303Z","caller":"traceutil/trace.go:171","msg":"trace[1407800176] transaction","detail":"{read_only:false; response_revision:13746; number_of_response:1; }","duration":"150.568619ms","start":"2026-05-18T01:07:04.55469Z","end":"2026-05-18T01:07:04.705259Z","steps":["trace[1407800176] 'process raft request'  (duration: 134.748236ms)","trace[1407800176] 'compare'  (duration: 15.588259ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:07:27.124379Z","caller":"traceutil/trace.go:171","msg":"trace[1638784435] transaction","detail":"{read_only:false; response_revision:14054; number_of_response:1; }","duration":"249.93918ms","start":"2026-05-18T01:07:26.874412Z","end":"2026-05-18T01:07:27.124351Z","steps":["trace[1638784435] 'process raft request'  (duration: 249.763517ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:07:27.131241Z","caller":"traceutil/trace.go:171","msg":"trace[755836332] linearizableReadLoop","detail":"{readStateIndex:14542; appliedIndex:14540; }","duration":"157.545467ms","start":"2026-05-18T01:07:26.973651Z","end":"2026-05-18T01:07:27.131197Z","steps":["trace[755836332] 'read index received'  (duration: 150.566918ms)","trace[755836332] 'applied index is now lower than readState.Index'  (duration: 6.977899ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:07:27.131375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.70541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-18T01:07:27.131415Z","caller":"traceutil/trace.go:171","msg":"trace[344654866] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14055; }","duration":"157.819203ms","start":"2026-05-18T01:07:26.973583Z","end":"2026-05-18T01:07:27.131403Z","steps":["trace[344654866] 'agreement among raft nodes before linearized reading'  (duration: 157.746272ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:07:27.131388Z","caller":"traceutil/trace.go:171","msg":"trace[1417564227] transaction","detail":"{read_only:false; response_revision:14055; number_of_response:1; }","duration":"230.464768ms","start":"2026-05-18T01:07:26.900879Z","end":"2026-05-18T01:07:27.131344Z","steps":["trace[1417564227] 'process raft request'  (duration: 230.214304ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:07:27.131528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.244557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-80e49301-2efe-43de-a48c-45b343de39e4\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-05-18T01:07:27.131598Z","caller":"traceutil/trace.go:171","msg":"trace[1532130492] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-80e49301-2efe-43de-a48c-45b343de39e4; range_end:; response_count:1; response_revision:14055; }","duration":"127.386399ms","start":"2026-05-18T01:07:27.004195Z","end":"2026-05-18T01:07:27.131582Z","steps":["trace[1532130492] 'agreement among raft nodes before linearized reading'  (duration: 127.177766ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:08:52.572134Z","caller":"traceutil/trace.go:171","msg":"trace[1582715594] linearizableReadLoop","detail":"{readStateIndex:15371; appliedIndex:15370; }","duration":"190.354145ms","start":"2026-05-18T01:08:52.381749Z","end":"2026-05-18T01:08:52.572103Z","steps":["trace[1582715594] 'read index received'  (duration: 190.178932ms)","trace[1582715594] 'applied index is now lower than readState.Index'  (duration: 173.953µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:08:52.57235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.56624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-18T01:08:52.572261Z","caller":"traceutil/trace.go:171","msg":"trace[1746155648] transaction","detail":"{read_only:false; response_revision:14861; number_of_response:1; }","duration":"205.17104ms","start":"2026-05-18T01:08:52.367025Z","end":"2026-05-18T01:08:52.572196Z","steps":["trace[1746155648] 'process raft request'  (duration: 204.871354ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:08:52.572462Z","caller":"traceutil/trace.go:171","msg":"trace[1487576260] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:14861; }","duration":"190.744302ms","start":"2026-05-18T01:08:52.381691Z","end":"2026-05-18T01:08:52.572435Z","steps":["trace[1487576260] 'agreement among raft nodes before linearized reading'  (duration: 190.551958ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:10:11.189452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13006}
{"level":"info","ts":"2026-05-18T01:10:11.273786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13006,"took":"80.943489ms","hash":316726687,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":31006720,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-18T01:10:11.273879Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":316726687,"revision":13006,"compact-revision":10944}
{"level":"warn","ts":"2026-05-18T01:14:04.154198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.892725ms","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-05-18T01:14:04.154279Z","caller":"traceutil/trace.go:171","msg":"trace[489342328] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:17251; }","duration":"185.036837ms","start":"2026-05-18T01:14:03.969226Z","end":"2026-05-18T01:14:04.154263Z","steps":["trace[489342328] 'range keys from in-memory index tree'  (duration: 184.719221ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:14:09.544581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.083268ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101180741 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:17273 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:14:09.544741Z","caller":"traceutil/trace.go:171","msg":"trace[2035863951] linearizableReadLoop","detail":"{readStateIndex:17874; appliedIndex:17873; }","duration":"298.754763ms","start":"2026-05-18T01:14:09.245964Z","end":"2026-05-18T01:14:09.544718Z","steps":["trace[2035863951] 'read index received'  (duration: 160.293719ms)","trace[2035863951] 'applied index is now lower than readState.Index'  (duration: 138.459234ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:14:09.545284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.326064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-568kx\" ","response":"range_response_count:1 size:20872"}
{"level":"warn","ts":"2026-05-18T01:14:09.545271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.364008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-18T01:14:09.545248Z","caller":"traceutil/trace.go:171","msg":"trace[909744331] transaction","detail":"{read_only:false; response_revision:17285; number_of_response:1; }","duration":"303.185896ms","start":"2026-05-18T01:14:09.24202Z","end":"2026-05-18T01:14:09.545206Z","steps":["trace[909744331] 'process raft request'  (duration: 164.341214ms)","trace[909744331] 'compare'  (duration: 137.490046ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:14:09.545352Z","caller":"traceutil/trace.go:171","msg":"trace[1955678494] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-568kx; range_end:; response_count:1; response_revision:17285; }","duration":"299.425186ms","start":"2026-05-18T01:14:09.2459Z","end":"2026-05-18T01:14:09.545326Z","steps":["trace[1955678494] 'agreement among raft nodes before linearized reading'  (duration: 299.146681ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:14:09.545393Z","caller":"traceutil/trace.go:171","msg":"trace[2047078428] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17285; }","duration":"121.542871ms","start":"2026-05-18T01:14:09.423815Z","end":"2026-05-18T01:14:09.545358Z","steps":["trace[2047078428] 'agreement among raft nodes before linearized reading'  (duration: 121.204655ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:14:09.545842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:14:09.241997Z","time spent":"303.582153ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:17273 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-18T01:14:09.81563Z","caller":"traceutil/trace.go:171","msg":"trace[1454530686] transaction","detail":"{read_only:false; response_revision:17286; number_of_response:1; }","duration":"264.366416ms","start":"2026-05-18T01:14:09.551244Z","end":"2026-05-18T01:14:09.81561Z","steps":["trace[1454530686] 'process raft request'  (duration: 264.223304ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:14:09.851185Z","caller":"traceutil/trace.go:171","msg":"trace[901295645] transaction","detail":"{read_only:false; response_revision:17287; number_of_response:1; }","duration":"287.558296ms","start":"2026-05-18T01:14:09.563577Z","end":"2026-05-18T01:14:09.851135Z","steps":["trace[901295645] 'process raft request'  (duration: 287.23731ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:14:09.914026Z","caller":"traceutil/trace.go:171","msg":"trace[2116266663] linearizableReadLoop","detail":"{readStateIndex:17877; appliedIndex:17874; }","duration":"228.495171ms","start":"2026-05-18T01:14:09.685496Z","end":"2026-05-18T01:14:09.913991Z","steps":["trace[2116266663] 'read index received'  (duration: 129.932416ms)","trace[2116266663] 'applied index is now lower than readState.Index'  (duration: 98.561405ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:14:09.914379Z","caller":"traceutil/trace.go:171","msg":"trace[988234257] transaction","detail":"{read_only:false; response_revision:17288; number_of_response:1; }","duration":"139.449282ms","start":"2026-05-18T01:14:09.774693Z","end":"2026-05-18T01:14:09.914143Z","steps":["trace[988234257] 'process raft request'  (duration: 139.026124ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:14:09.914451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.93757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-dmlqg\" ","response":"range_response_count:1 size:9800"}
{"level":"info","ts":"2026-05-18T01:14:09.914529Z","caller":"traceutil/trace.go:171","msg":"trace[44149773] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-dmlqg; range_end:; response_count:1; response_revision:17288; }","duration":"229.095442ms","start":"2026-05-18T01:14:09.685416Z","end":"2026-05-18T01:14:09.914512Z","steps":["trace[44149773] 'agreement among raft nodes before linearized reading'  (duration: 228.803187ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:14:09.91473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.747509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"warn","ts":"2026-05-18T01:14:09.914871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.327771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-18T01:14:09.915053Z","caller":"traceutil/trace.go:171","msg":"trace[729353181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17288; }","duration":"125.584546ms","start":"2026-05-18T01:14:09.789438Z","end":"2026-05-18T01:14:09.915023Z","steps":["trace[729353181] 'agreement among raft nodes before linearized reading'  (duration: 125.220358ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:14:09.915015Z","caller":"traceutil/trace.go:171","msg":"trace[1690534041] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17288; }","duration":"200.908502ms","start":"2026-05-18T01:14:09.713882Z","end":"2026-05-18T01:14:09.914791Z","steps":["trace[1690534041] 'agreement among raft nodes before linearized reading'  (duration: 200.490213ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:15:11.198662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15395}
{"level":"info","ts":"2026-05-18T01:15:11.299129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15395,"took":"95.665671ms","hash":119837595,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":33730560,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-18T01:15:11.299214Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":119837595,"revision":15395,"compact-revision":13006}
{"level":"info","ts":"2026-05-18T01:18:10.553957Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-18T01:18:10.56105Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-18T01:18:10.561187Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-18T01:19:40.617028Z","caller":"traceutil/trace.go:171","msg":"trace[1808938669] transaction","detail":"{read_only:false; response_revision:19880; number_of_response:1; }","duration":"123.540488ms","start":"2026-05-18T01:19:40.493421Z","end":"2026-05-18T01:19:40.616961Z","steps":["trace[1808938669] 'process raft request'  (duration: 123.304564ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:19:41.996736Z","caller":"traceutil/trace.go:171","msg":"trace[336398008] linearizableReadLoop","detail":"{readStateIndex:20558; appliedIndex:20556; }","duration":"169.111363ms","start":"2026-05-18T01:19:41.8276Z","end":"2026-05-18T01:19:41.996711Z","steps":["trace[336398008] 'read index received'  (duration: 8.472397ms)","trace[336398008] 'applied index is now lower than readState.Index'  (duration: 160.638096ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:19:41.996866Z","caller":"traceutil/trace.go:171","msg":"trace[1953510687] transaction","detail":"{read_only:false; response_revision:19884; number_of_response:1; }","duration":"214.444332ms","start":"2026-05-18T01:19:41.782411Z","end":"2026-05-18T01:19:41.996856Z","steps":["trace[1953510687] 'process raft request'  (duration: 214.041875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:19:41.997212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.570951ms","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-05-18T01:19:41.997365Z","caller":"traceutil/trace.go:171","msg":"trace[393523298] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19884; }","duration":"169.757865ms","start":"2026-05-18T01:19:41.827565Z","end":"2026-05-18T01:19:41.997322Z","steps":["trace[393523298] 'agreement among raft nodes before linearized reading'  (duration: 169.383518ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:20:11.20567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17983}
{"level":"info","ts":"2026-05-18T01:20:11.317867Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17983,"took":"107.941099ms","hash":3255610720,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":29446144,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-18T01:20:11.317935Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3255610720,"revision":17983,"compact-revision":15395}
{"level":"info","ts":"2026-05-18T01:23:29.670505Z","caller":"traceutil/trace.go:171","msg":"trace[2129156770] transaction","detail":"{read_only:false; response_revision:22284; number_of_response:1; }","duration":"166.709285ms","start":"2026-05-18T01:23:29.503761Z","end":"2026-05-18T01:23:29.67047Z","steps":["trace[2129156770] 'process raft request'  (duration: 164.490403ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:25:11.212545Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20151}
{"level":"info","ts":"2026-05-18T01:25:11.351643Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20151,"took":"128.523637ms","hash":4015792063,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":41730048,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-18T01:25:11.351746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4015792063,"revision":20151,"compact-revision":17983}
{"level":"info","ts":"2026-05-18T01:25:29.191682Z","caller":"traceutil/trace.go:171","msg":"trace[1572591102] transaction","detail":"{read_only:false; response_revision:23517; number_of_response:1; }","duration":"105.401622ms","start":"2026-05-18T01:25:29.086226Z","end":"2026-05-18T01:25:29.191628Z","steps":["trace[1572591102] 'process raft request'  (duration: 75.096762ms)","trace[1572591102] 'compare'  (duration: 29.952062ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:26:58.465052Z","caller":"traceutil/trace.go:171","msg":"trace[1574402842] transaction","detail":"{read_only:false; response_revision:24399; number_of_response:1; }","duration":"100.115612ms","start":"2026-05-18T01:26:58.364865Z","end":"2026-05-18T01:26:58.46498Z","steps":["trace[1574402842] 'process raft request'  (duration: 99.713554ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:03.983909Z","caller":"traceutil/trace.go:171","msg":"trace[2108715351] transaction","detail":"{read_only:false; response_revision:24448; number_of_response:1; }","duration":"189.245278ms","start":"2026-05-18T01:27:03.794639Z","end":"2026-05-18T01:27:03.983884Z","steps":["trace[2108715351] 'process raft request'  (duration: 189.107716ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:03.984106Z","caller":"traceutil/trace.go:171","msg":"trace[746613694] linearizableReadLoop","detail":"{readStateIndex:25253; appliedIndex:25253; }","duration":"161.812293ms","start":"2026-05-18T01:27:03.822267Z","end":"2026-05-18T01:27:03.98408Z","steps":["trace[746613694] 'read index received'  (duration: 161.800683ms)","trace[746613694] 'applied index is now lower than readState.Index'  (duration: 9.22µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:03.984333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.053808ms","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-05-18T01:27:03.984357Z","caller":"traceutil/trace.go:171","msg":"trace[1226001453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24448; }","duration":"162.094409ms","start":"2026-05-18T01:27:03.822257Z","end":"2026-05-18T01:27:03.984351Z","steps":["trace[1226001453] 'agreement among raft nodes before linearized reading'  (duration: 161.940936ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:04.075214Z","caller":"traceutil/trace.go:171","msg":"trace[1395161154] transaction","detail":"{read_only:false; response_revision:24449; number_of_response:1; }","duration":"133.261216ms","start":"2026-05-18T01:27:03.941921Z","end":"2026-05-18T01:27:04.075182Z","steps":["trace[1395161154] 'process raft request'  (duration: 133.121324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:04.385377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.405011ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200644 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24424 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:04.385513Z","caller":"traceutil/trace.go:171","msg":"trace[808171439] linearizableReadLoop","detail":"{readStateIndex:25255; appliedIndex:25254; }","duration":"309.040812ms","start":"2026-05-18T01:27:04.076451Z","end":"2026-05-18T01:27:04.385491Z","steps":["trace[808171439] 'read index received'  (duration: 134.360226ms)","trace[808171439] 'applied index is now lower than readState.Index'  (duration: 174.678926ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:04.385808Z","caller":"traceutil/trace.go:171","msg":"trace[454435496] transaction","detail":"{read_only:false; response_revision:24450; number_of_response:1; }","duration":"394.291215ms","start":"2026-05-18T01:27:03.991502Z","end":"2026-05-18T01:27:04.385794Z","steps":["trace[454435496] 'process raft request'  (duration: 219.345574ms)","trace[454435496] 'compare'  (duration: 172.915252ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:04.385886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:03.991474Z","time spent":"394.376297ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24424 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-18T01:27:04.386138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.681174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:04.386175Z","caller":"traceutil/trace.go:171","msg":"trace[956188142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24450; }","duration":"309.717645ms","start":"2026-05-18T01:27:04.076447Z","end":"2026-05-18T01:27:04.386165Z","steps":["trace[956188142] 'agreement among raft nodes before linearized reading'  (duration: 309.649213ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:04.386205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:04.076405Z","time spent":"309.794486ms","remote":"127.0.0.1:50218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-18T01:27:04.386392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.383104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:27:04.386429Z","caller":"traceutil/trace.go:171","msg":"trace[1218237701] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:24450; }","duration":"271.455855ms","start":"2026-05-18T01:27:04.114964Z","end":"2026-05-18T01:27:04.38642Z","steps":["trace[1218237701] 'agreement among raft nodes before linearized reading'  (duration: 271.389274ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:04.560431Z","caller":"traceutil/trace.go:171","msg":"trace[2057461359] transaction","detail":"{read_only:false; response_revision:24451; number_of_response:1; }","duration":"158.706064ms","start":"2026-05-18T01:27:04.401692Z","end":"2026-05-18T01:27:04.560398Z","steps":["trace[2057461359] 'process raft request'  (duration: 118.678772ms)","trace[2057461359] 'compare'  (duration: 39.659665ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:08.520767Z","caller":"traceutil/trace.go:171","msg":"trace[1837293182] transaction","detail":"{read_only:false; response_revision:24481; number_of_response:1; }","duration":"113.565136ms","start":"2026-05-18T01:27:08.407173Z","end":"2026-05-18T01:27:08.520738Z","steps":["trace[1837293182] 'process raft request'  (duration: 113.394343ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:08.761403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.586148ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200720 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24468 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:08.761563Z","caller":"traceutil/trace.go:171","msg":"trace[1285676991] linearizableReadLoop","detail":"{readStateIndex:25289; appliedIndex:25287; }","duration":"179.17576ms","start":"2026-05-18T01:27:08.582374Z","end":"2026-05-18T01:27:08.76155Z","steps":["trace[1285676991] 'read index received'  (duration: 16.359808ms)","trace[1285676991] 'applied index is now lower than readState.Index'  (duration: 162.815202ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:08.761646Z","caller":"traceutil/trace.go:171","msg":"trace[331804685] transaction","detail":"{read_only:false; response_revision:24482; number_of_response:1; }","duration":"187.687179ms","start":"2026-05-18T01:27:08.57395Z","end":"2026-05-18T01:27:08.761638Z","steps":["trace[331804685] 'process raft request'  (duration: 24.793036ms)","trace[331804685] 'compare'  (duration: 162.435275ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:08.761926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.581348ms","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-05-18T01:27:08.761948Z","caller":"traceutil/trace.go:171","msg":"trace[1991888099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24483; }","duration":"170.632779ms","start":"2026-05-18T01:27:08.591308Z","end":"2026-05-18T01:27:08.761941Z","steps":["trace[1991888099] 'agreement among raft nodes before linearized reading'  (duration: 170.512547ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:08.761929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.539616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-18T01:27:08.762038Z","caller":"traceutil/trace.go:171","msg":"trace[1258352720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24483; }","duration":"179.704339ms","start":"2026-05-18T01:27:08.582307Z","end":"2026-05-18T01:27:08.762012Z","steps":["trace[1258352720] 'agreement among raft nodes before linearized reading'  (duration: 179.444714ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:08.762115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.200275ms","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-05-18T01:27:08.76215Z","caller":"traceutil/trace.go:171","msg":"trace[834881012] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24483; }","duration":"167.257446ms","start":"2026-05-18T01:27:08.594884Z","end":"2026-05-18T01:27:08.762141Z","steps":["trace[834881012] 'agreement among raft nodes before linearized reading'  (duration: 167.185004ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:08.762222Z","caller":"traceutil/trace.go:171","msg":"trace[725046277] transaction","detail":"{read_only:false; response_revision:24483; number_of_response:1; }","duration":"187.429715ms","start":"2026-05-18T01:27:08.57478Z","end":"2026-05-18T01:27:08.76221Z","steps":["trace[725046277] 'process raft request'  (duration: 186.700211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.114493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.219166ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200724 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24469 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:09.114654Z","caller":"traceutil/trace.go:171","msg":"trace[517647953] linearizableReadLoop","detail":"{readStateIndex:25292; appliedIndex:25289; }","duration":"319.03049ms","start":"2026-05-18T01:27:08.795611Z","end":"2026-05-18T01:27:09.114641Z","steps":["trace[517647953] 'read index received'  (duration: 185.60757ms)","trace[517647953] 'applied index is now lower than readState.Index'  (duration: 133.4221ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:09.114717Z","caller":"traceutil/trace.go:171","msg":"trace[712269080] transaction","detail":"{read_only:false; response_revision:24485; number_of_response:1; }","duration":"347.469914ms","start":"2026-05-18T01:27:08.76724Z","end":"2026-05-18T01:27:09.11471Z","steps":["trace[712269080] 'process raft request'  (duration: 347.341572ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.114757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:08.767215Z","time spent":"347.520376ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24470 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-18T01:27:09.114799Z","caller":"traceutil/trace.go:171","msg":"trace[8079775] transaction","detail":"{read_only:false; response_revision:24484; number_of_response:1; }","duration":"348.188327ms","start":"2026-05-18T01:27:08.76659Z","end":"2026-05-18T01:27:09.114778Z","steps":["trace[8079775] 'process raft request'  (duration: 214.612225ms)","trace[8079775] 'compare'  (duration: 132.779278ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:09.114889Z","caller":"traceutil/trace.go:171","msg":"trace[1239573080] transaction","detail":"{read_only:false; response_revision:24486; number_of_response:1; }","duration":"347.571116ms","start":"2026-05-18T01:27:08.76731Z","end":"2026-05-18T01:27:09.114881Z","steps":["trace[1239573080] 'process raft request'  (duration: 347.308491ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.114882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:08.766559Z","time spent":"348.280319ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24469 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-18T01:27:09.114929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:08.767303Z","time spent":"347.604507ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24471 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-18T01:27:09.114997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.384126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:09.115017Z","caller":"traceutil/trace.go:171","msg":"trace[1113210368] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:24486; }","duration":"319.421357ms","start":"2026-05-18T01:27:08.795587Z","end":"2026-05-18T01:27:09.115008Z","steps":["trace[1113210368] 'agreement among raft nodes before linearized reading'  (duration: 319.384606ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.115039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:08.795574Z","time spent":"319.459998ms","remote":"127.0.0.1:40794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "}
{"level":"warn","ts":"2026-05-18T01:27:09.115292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.306249ms","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-05-18T01:27:09.11536Z","caller":"traceutil/trace.go:171","msg":"trace[309727898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24486; }","duration":"248.410771ms","start":"2026-05-18T01:27:08.866934Z","end":"2026-05-18T01:27:09.115344Z","steps":["trace[309727898] 'agreement among raft nodes before linearized reading'  (duration: 248.224717ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.115486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.839364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"warn","ts":"2026-05-18T01:27:09.115488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.762605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:09.115566Z","caller":"traceutil/trace.go:171","msg":"trace[389324443] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24486; }","duration":"244.949266ms","start":"2026-05-18T01:27:08.870578Z","end":"2026-05-18T01:27:09.115527Z","steps":["trace[389324443] 'agreement among raft nodes before linearized reading'  (duration: 244.820054ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:09.115594Z","caller":"traceutil/trace.go:171","msg":"trace[1212236792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24486; }","duration":"141.913458ms","start":"2026-05-18T01:27:08.973656Z","end":"2026-05-18T01:27:09.11557Z","steps":["trace[1212236792] 'agreement among raft nodes before linearized reading'  (duration: 141.737695ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.521146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.578332ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200730 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24473 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:09.521459Z","caller":"traceutil/trace.go:171","msg":"trace[1110704208] transaction","detail":"{read_only:false; response_revision:24488; number_of_response:1; }","duration":"399.285698ms","start":"2026-05-18T01:27:09.122151Z","end":"2026-05-18T01:27:09.521436Z","steps":["trace[1110704208] 'process raft request'  (duration: 399.151075ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.52155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:09.122127Z","time spent":"399.38073ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24474 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-18T01:27:09.521702Z","caller":"traceutil/trace.go:171","msg":"trace[1566275146] transaction","detail":"{read_only:false; response_revision:24487; number_of_response:1; }","duration":"400.96771ms","start":"2026-05-18T01:27:09.120659Z","end":"2026-05-18T01:27:09.521627Z","steps":["trace[1566275146] 'process raft request'  (duration: 124.736956ms)","trace[1566275146] 'compare'  (duration: 275.294097ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:09.522037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:09.120632Z","time spent":"401.253625ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24473 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-18T01:27:09.546487Z","caller":"traceutil/trace.go:171","msg":"trace[1178712125] transaction","detail":"{read_only:false; response_revision:24489; number_of_response:1; }","duration":"216.279628ms","start":"2026-05-18T01:27:09.330141Z","end":"2026-05-18T01:27:09.54642Z","steps":["trace[1178712125] 'process raft request'  (duration: 215.026285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:09.774562Z","caller":"traceutil/trace.go:171","msg":"trace[1580473348] linearizableReadLoop","detail":"{readStateIndex:25297; appliedIndex:25296; }","duration":"123.208717ms","start":"2026-05-18T01:27:09.651318Z","end":"2026-05-18T01:27:09.774527Z","steps":["trace[1580473348] 'read index received'  (duration: 36.879903ms)","trace[1580473348] 'applied index is now lower than readState.Index'  (duration: 86.327764ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:09.774792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.429791ms","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-05-18T01:27:09.774825Z","caller":"traceutil/trace.go:171","msg":"trace[1115934916] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24490; }","duration":"123.545633ms","start":"2026-05-18T01:27:09.651267Z","end":"2026-05-18T01:27:09.774813Z","steps":["trace[1115934916] 'agreement among raft nodes before linearized reading'  (duration: 123.441101ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:09.775057Z","caller":"traceutil/trace.go:171","msg":"trace[764373462] transaction","detail":"{read_only:false; response_revision:24491; number_of_response:1; }","duration":"120.579097ms","start":"2026-05-18T01:27:09.654451Z","end":"2026-05-18T01:27:09.77503Z","steps":["trace[764373462] 'process raft request'  (duration: 119.947765ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:09.775099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.757611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-18T01:27:09.775209Z","caller":"traceutil/trace.go:171","msg":"trace[1488223775] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:24491; }","duration":"104.916054ms","start":"2026-05-18T01:27:09.670266Z","end":"2026-05-18T01:27:09.775182Z","steps":["trace[1488223775] 'agreement among raft nodes before linearized reading'  (duration: 104.576448ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:10.247296Z","caller":"traceutil/trace.go:171","msg":"trace[1631849986] transaction","detail":"{read_only:false; response_revision:24492; number_of_response:1; }","duration":"239.86199ms","start":"2026-05-18T01:27:10.007401Z","end":"2026-05-18T01:27:10.247263Z","steps":["trace[1631849986] 'process raft request'  (duration: 239.654257ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:10.247417Z","caller":"traceutil/trace.go:171","msg":"trace[272969079] linearizableReadLoop","detail":"{readStateIndex:25299; appliedIndex:25299; }","duration":"230.694548ms","start":"2026-05-18T01:27:10.016676Z","end":"2026-05-18T01:27:10.24737Z","steps":["trace[272969079] 'read index received'  (duration: 230.673668ms)","trace[272969079] 'applied index is now lower than readState.Index'  (duration: 17.83µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:10.247763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.050985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:27:10.247844Z","caller":"traceutil/trace.go:171","msg":"trace[561748932] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:24492; }","duration":"231.192558ms","start":"2026-05-18T01:27:10.016633Z","end":"2026-05-18T01:27:10.247825Z","steps":["trace[561748932] 'agreement among raft nodes before linearized reading'  (duration: 230.935323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:10.491231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.768598ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200740 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24480 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:504 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:10.491407Z","caller":"traceutil/trace.go:171","msg":"trace[85261130] linearizableReadLoop","detail":"{readStateIndex:25300; appliedIndex:25299; }","duration":"243.872136ms","start":"2026-05-18T01:27:10.247507Z","end":"2026-05-18T01:27:10.491379Z","steps":["trace[85261130] 'read index received'  (duration: 103.777661ms)","trace[85261130] 'applied index is now lower than readState.Index'  (duration: 140.091615ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:10.49158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.394932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:27:10.491674Z","caller":"traceutil/trace.go:171","msg":"trace[847161658] transaction","detail":"{read_only:false; response_revision:24493; number_of_response:1; }","duration":"392.505161ms","start":"2026-05-18T01:27:10.099095Z","end":"2026-05-18T01:27:10.491601Z","steps":["trace[847161658] 'process raft request'  (duration: 252.218123ms)","trace[847161658] 'compare'  (duration: 139.521904ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:10.491923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:10.09907Z","time spent":"392.716456ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24480 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:504 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-18T01:27:10.49197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.062946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-05-18T01:27:10.492088Z","caller":"traceutil/trace.go:171","msg":"trace[94103490] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:24493; }","duration":"247.490315ms","start":"2026-05-18T01:27:10.244116Z","end":"2026-05-18T01:27:10.491607Z","steps":["trace[94103490] 'agreement among raft nodes before linearized reading'  (duration: 247.331901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:10.492129Z","caller":"traceutil/trace.go:171","msg":"trace[1019721937] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:24493; }","duration":"247.272131ms","start":"2026-05-18T01:27:10.244816Z","end":"2026-05-18T01:27:10.492088Z","steps":["trace[1019721937] 'agreement among raft nodes before linearized reading'  (duration: 246.787221ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:10.818208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.739621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:10.818316Z","caller":"traceutil/trace.go:171","msg":"trace[640321195] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24494; }","duration":"128.947675ms","start":"2026-05-18T01:27:10.689346Z","end":"2026-05-18T01:27:10.818294Z","steps":["trace[640321195] 'range keys from in-memory index tree'  (duration: 128.522798ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:11.388376Z","caller":"traceutil/trace.go:171","msg":"trace[1805178153] transaction","detail":"{read_only:false; response_revision:24497; number_of_response:1; }","duration":"264.944263ms","start":"2026-05-18T01:27:11.123395Z","end":"2026-05-18T01:27:11.38834Z","steps":["trace[1805178153] 'process raft request'  (duration: 264.76675ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:11.39982Z","caller":"traceutil/trace.go:171","msg":"trace[1351290972] linearizableReadLoop","detail":"{readStateIndex:25307; appliedIndex:25304; }","duration":"127.6179ms","start":"2026-05-18T01:27:11.272179Z","end":"2026-05-18T01:27:11.399796Z","steps":["trace[1351290972] 'read index received'  (duration: 116.666504ms)","trace[1351290972] 'applied index is now lower than readState.Index'  (duration: 10.950206ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:11.399925Z","caller":"traceutil/trace.go:171","msg":"trace[828511637] transaction","detail":"{read_only:false; response_revision:24498; number_of_response:1; }","duration":"275.661164ms","start":"2026-05-18T01:27:11.124256Z","end":"2026-05-18T01:27:11.399917Z","steps":["trace[828511637] 'process raft request'  (duration: 275.194416ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:11.400127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.919035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:11.400192Z","caller":"traceutil/trace.go:171","msg":"trace[2059282627] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:24500; }","duration":"128.046458ms","start":"2026-05-18T01:27:11.27213Z","end":"2026-05-18T01:27:11.400177Z","steps":["trace[2059282627] 'agreement among raft nodes before linearized reading'  (duration: 127.920766ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:11.400316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.80525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:27:11.400363Z","caller":"traceutil/trace.go:171","msg":"trace[1523240668] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:24500; }","duration":"113.895092ms","start":"2026-05-18T01:27:11.286456Z","end":"2026-05-18T01:27:11.400352Z","steps":["trace[1523240668] 'agreement among raft nodes before linearized reading'  (duration: 113.79316ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:11.400377Z","caller":"traceutil/trace.go:171","msg":"trace[1443678633] transaction","detail":"{read_only:false; response_revision:24499; number_of_response:1; }","duration":"274.792098ms","start":"2026-05-18T01:27:11.125572Z","end":"2026-05-18T01:27:11.400364Z","steps":["trace[1443678633] 'process raft request'  (duration: 274.139915ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:11.400569Z","caller":"traceutil/trace.go:171","msg":"trace[388595975] transaction","detail":"{read_only:false; response_revision:24500; number_of_response:1; }","duration":"251.301966ms","start":"2026-05-18T01:27:11.149256Z","end":"2026-05-18T01:27:11.400557Z","steps":["trace[388595975] 'process raft request'  (duration: 250.494371ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:11.6521Z","caller":"traceutil/trace.go:171","msg":"trace[510660214] transaction","detail":"{read_only:false; response_revision:24501; number_of_response:1; }","duration":"120.424114ms","start":"2026-05-18T01:27:11.531652Z","end":"2026-05-18T01:27:11.652076Z","steps":["trace[510660214] 'process raft request'  (duration: 120.265701ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:12.055324Z","caller":"traceutil/trace.go:171","msg":"trace[772749392] transaction","detail":"{read_only:false; response_revision:24504; number_of_response:1; }","duration":"458.560644ms","start":"2026-05-18T01:27:11.596735Z","end":"2026-05-18T01:27:12.055296Z","steps":["trace[772749392] 'process raft request'  (duration: 458.522413ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:12.055479Z","caller":"traceutil/trace.go:171","msg":"trace[1494256126] transaction","detail":"{read_only:false; response_revision:24502; number_of_response:1; }","duration":"522.1525ms","start":"2026-05-18T01:27:11.533298Z","end":"2026-05-18T01:27:12.05545Z","steps":["trace[1494256126] 'process raft request'  (duration: 521.761253ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.055508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:11.596694Z","time spent":"458.713607ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24490 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-18T01:27:12.055497Z","caller":"traceutil/trace.go:171","msg":"trace[1788653565] transaction","detail":"{read_only:false; response_revision:24503; number_of_response:1; }","duration":"503.259454ms","start":"2026-05-18T01:27:11.55221Z","end":"2026-05-18T01:27:12.055469Z","steps":["trace[1788653565] 'process raft request'  (duration: 503.01738ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.055653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:11.533254Z","time spent":"522.297903ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24488 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-18T01:27:12.05566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:11.55219Z","time spent":"503.373606ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24489 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-18T01:27:12.066394Z","caller":"traceutil/trace.go:171","msg":"trace[1412564256] transaction","detail":"{read_only:false; response_revision:24505; number_of_response:1; }","duration":"274.458101ms","start":"2026-05-18T01:27:11.79192Z","end":"2026-05-18T01:27:12.066379Z","steps":["trace[1412564256] 'process raft request'  (duration: 274.267648ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.066515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.143959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:12.066373Z","caller":"traceutil/trace.go:171","msg":"trace[981684246] linearizableReadLoop","detail":"{readStateIndex:25312; appliedIndex:25308; }","duration":"112.994525ms","start":"2026-05-18T01:27:11.95336Z","end":"2026-05-18T01:27:12.066354Z","steps":["trace[981684246] 'read index received'  (duration: 101.794365ms)","trace[981684246] 'applied index is now lower than readState.Index'  (duration: 11.19947ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:12.066587Z","caller":"traceutil/trace.go:171","msg":"trace[796803395] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:24506; }","duration":"113.26867ms","start":"2026-05-18T01:27:11.953306Z","end":"2026-05-18T01:27:12.066575Z","steps":["trace[796803395] 'agreement among raft nodes before linearized reading'  (duration: 113.149938ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:12.387969Z","caller":"traceutil/trace.go:171","msg":"trace[59980900] linearizableReadLoop","detail":"{readStateIndex:25314; appliedIndex:25313; }","duration":"102.310304ms","start":"2026-05-18T01:27:12.285627Z","end":"2026-05-18T01:27:12.387937Z","steps":["trace[59980900] 'read index received'  (duration: 102.028139ms)","trace[59980900] 'applied index is now lower than readState.Index'  (duration: 280.935µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:12.388091Z","caller":"traceutil/trace.go:171","msg":"trace[610215428] transaction","detail":"{read_only:false; response_revision:24507; number_of_response:1; }","duration":"134.278784ms","start":"2026-05-18T01:27:12.253781Z","end":"2026-05-18T01:27:12.38806Z","steps":["trace[610215428] 'process raft request'  (duration: 133.948718ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.38816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.496887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:27:12.388201Z","caller":"traceutil/trace.go:171","msg":"trace[174501823] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:24507; }","duration":"102.614141ms","start":"2026-05-18T01:27:12.285575Z","end":"2026-05-18T01:27:12.388189Z","steps":["trace[174501823] 'agreement among raft nodes before linearized reading'  (duration: 102.494957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:12.735164Z","caller":"traceutil/trace.go:171","msg":"trace[697680588] linearizableReadLoop","detail":"{readStateIndex:25315; appliedIndex:25314; }","duration":"214.911301ms","start":"2026-05-18T01:27:12.520218Z","end":"2026-05-18T01:27:12.73513Z","steps":["trace[697680588] 'read index received'  (duration: 214.393822ms)","trace[697680588] 'applied index is now lower than readState.Index'  (duration: 511.449µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:12.735335Z","caller":"traceutil/trace.go:171","msg":"trace[682667149] transaction","detail":"{read_only:false; response_revision:24508; number_of_response:1; }","duration":"235.836615ms","start":"2026-05-18T01:27:12.499437Z","end":"2026-05-18T01:27:12.735274Z","steps":["trace[682667149] 'process raft request'  (duration: 235.479648ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.73556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.312679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-18T01:27:12.735612Z","caller":"traceutil/trace.go:171","msg":"trace[1641832361] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24508; }","duration":"215.440452ms","start":"2026-05-18T01:27:12.520159Z","end":"2026-05-18T01:27:12.735599Z","steps":["trace[1641832361] 'agreement among raft nodes before linearized reading'  (duration: 215.220427ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.735898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.129659ms","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-05-18T01:27:12.73597Z","caller":"traceutil/trace.go:171","msg":"trace[1755805977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24508; }","duration":"179.267271ms","start":"2026-05-18T01:27:12.556682Z","end":"2026-05-18T01:27:12.735949Z","steps":["trace[1755805977] 'agreement among raft nodes before linearized reading'  (duration: 179.000966ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.736033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.4964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:12.736141Z","caller":"traceutil/trace.go:171","msg":"trace[344682900] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24508; }","duration":"143.646032ms","start":"2026-05-18T01:27:12.592471Z","end":"2026-05-18T01:27:12.736117Z","steps":["trace[344682900] 'agreement among raft nodes before linearized reading'  (duration: 143.422448ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:12.736096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.269831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:12.736225Z","caller":"traceutil/trace.go:171","msg":"trace[1607891062] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24508; }","duration":"155.497845ms","start":"2026-05-18T01:27:12.580696Z","end":"2026-05-18T01:27:12.736194Z","steps":["trace[1607891062] 'agreement among raft nodes before linearized reading'  (duration: 155.21931ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:13.018709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.264743ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200782 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24494 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:13.019065Z","caller":"traceutil/trace.go:171","msg":"trace[885990999] linearizableReadLoop","detail":"{readStateIndex:25318; appliedIndex:25315; }","duration":"155.356652ms","start":"2026-05-18T01:27:12.863687Z","end":"2026-05-18T01:27:13.019044Z","steps":["trace[885990999] 'read index received'  (duration: 1.666672ms)","trace[885990999] 'applied index is now lower than readState.Index'  (duration: 153.68845ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:13.019187Z","caller":"traceutil/trace.go:171","msg":"trace[928948151] transaction","detail":"{read_only:false; response_revision:24509; number_of_response:1; }","duration":"276.239546ms","start":"2026-05-18T01:27:12.742933Z","end":"2026-05-18T01:27:13.019173Z","steps":["trace[928948151] 'process raft request'  (duration: 122.390002ms)","trace[928948151] 'compare'  (duration: 152.991177ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:13.019282Z","caller":"traceutil/trace.go:171","msg":"trace[1539831828] transaction","detail":"{read_only:false; response_revision:24511; number_of_response:1; }","duration":"183.727056ms","start":"2026-05-18T01:27:12.835522Z","end":"2026-05-18T01:27:13.019249Z","steps":["trace[1539831828] 'process raft request'  (duration: 183.478361ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:13.019437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.737939ms","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-05-18T01:27:13.019478Z","caller":"traceutil/trace.go:171","msg":"trace[928674827] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24511; }","duration":"155.826181ms","start":"2026-05-18T01:27:12.863641Z","end":"2026-05-18T01:27:13.019468Z","steps":["trace[928674827] 'agreement among raft nodes before linearized reading'  (duration: 155.689059ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:13.019452Z","caller":"traceutil/trace.go:171","msg":"trace[363128389] transaction","detail":"{read_only:false; response_revision:24510; number_of_response:1; }","duration":"193.787835ms","start":"2026-05-18T01:27:12.825596Z","end":"2026-05-18T01:27:13.019384Z","steps":["trace[363128389] 'process raft request'  (duration: 193.257775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:13.635138Z","caller":"traceutil/trace.go:171","msg":"trace[1257441512] transaction","detail":"{read_only:false; response_revision:24513; number_of_response:1; }","duration":"148.663436ms","start":"2026-05-18T01:27:13.486437Z","end":"2026-05-18T01:27:13.6351Z","steps":["trace[1257441512] 'process raft request'  (duration: 148.395501ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:13.660708Z","caller":"traceutil/trace.go:171","msg":"trace[1077817276] transaction","detail":"{read_only:false; response_revision:24514; number_of_response:1; }","duration":"173.35874ms","start":"2026-05-18T01:27:13.487314Z","end":"2026-05-18T01:27:13.660673Z","steps":["trace[1077817276] 'process raft request'  (duration: 173.106346ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:13.660779Z","caller":"traceutil/trace.go:171","msg":"trace[1283869538] transaction","detail":"{read_only:false; response_revision:24515; number_of_response:1; }","duration":"172.517964ms","start":"2026-05-18T01:27:13.488213Z","end":"2026-05-18T01:27:13.660731Z","steps":["trace[1283869538] 'process raft request'  (duration: 172.30581ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:13.823437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.408122ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101200800 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24501 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:13.823642Z","caller":"traceutil/trace.go:171","msg":"trace[1167520739] transaction","detail":"{read_only:false; response_revision:24516; number_of_response:1; }","duration":"157.346239ms","start":"2026-05-18T01:27:13.666268Z","end":"2026-05-18T01:27:13.823614Z","steps":["trace[1167520739] 'process raft request'  (duration: 17.604071ms)","trace[1167520739] 'compare'  (duration: 139.185848ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:26.390003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.101377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0937791e-8b62-4707-8d8f-54c15f325a57\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-05-18T01:27:26.390079Z","caller":"traceutil/trace.go:171","msg":"trace[119712346] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0937791e-8b62-4707-8d8f-54c15f325a57; range_end:; response_count:1; response_revision:24668; }","duration":"197.201989ms","start":"2026-05-18T01:27:26.192861Z","end":"2026-05-18T01:27:26.390063Z","steps":["trace[119712346] 'range keys from in-memory index tree'  (duration: 196.825832ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:27.063625Z","caller":"traceutil/trace.go:171","msg":"trace[189251988] transaction","detail":"{read_only:false; response_revision:24671; number_of_response:1; }","duration":"269.870415ms","start":"2026-05-18T01:27:26.793722Z","end":"2026-05-18T01:27:27.063593Z","steps":["trace[189251988] 'process raft request'  (duration: 269.536438ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:27.37838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.806307ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101201218 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24624 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:27.378495Z","caller":"traceutil/trace.go:171","msg":"trace[1299644920] linearizableReadLoop","detail":"{readStateIndex:25486; appliedIndex:25485; }","duration":"121.040417ms","start":"2026-05-18T01:27:27.257437Z","end":"2026-05-18T01:27:27.378478Z","steps":["trace[1299644920] 'read index received'  (duration: 123.402µs)","trace[1299644920] 'applied index is now lower than readState.Index'  (duration: 120.915795ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:27.378648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.220621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"}
{"level":"info","ts":"2026-05-18T01:27:27.37861Z","caller":"traceutil/trace.go:171","msg":"trace[774193185] transaction","detail":"{read_only:false; response_revision:24675; number_of_response:1; }","duration":"268.317056ms","start":"2026-05-18T01:27:27.110241Z","end":"2026-05-18T01:27:27.378559Z","steps":["trace[774193185] 'process raft request'  (duration: 126.310136ms)","trace[774193185] 'compare'  (duration: 141.603532ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:27.378696Z","caller":"traceutil/trace.go:171","msg":"trace[1198124955] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:24675; }","duration":"121.310172ms","start":"2026-05-18T01:27:27.257365Z","end":"2026-05-18T01:27:27.378676Z","steps":["trace[1198124955] 'agreement among raft nodes before linearized reading'  (duration: 121.16087ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:27.937728Z","caller":"traceutil/trace.go:171","msg":"trace[1551317828] linearizableReadLoop","detail":"{readStateIndex:25487; appliedIndex:25486; }","duration":"211.975156ms","start":"2026-05-18T01:27:27.725716Z","end":"2026-05-18T01:27:27.937691Z","steps":["trace[1551317828] 'read index received'  (duration: 211.67902ms)","trace[1551317828] 'applied index is now lower than readState.Index'  (duration: 294.276µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:27.93782Z","caller":"traceutil/trace.go:171","msg":"trace[810975101] transaction","detail":"{read_only:false; response_revision:24676; number_of_response:1; }","duration":"232.875969ms","start":"2026-05-18T01:27:27.704901Z","end":"2026-05-18T01:27:27.937777Z","steps":["trace[810975101] 'process raft request'  (duration: 232.572514ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:27.937982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.783124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-18T01:27:27.938037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.301261ms","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-05-18T01:27:27.938115Z","caller":"traceutil/trace.go:171","msg":"trace[859332627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24676; }","duration":"212.398313ms","start":"2026-05-18T01:27:27.725702Z","end":"2026-05-18T01:27:27.9381Z","steps":["trace[859332627] 'agreement among raft nodes before linearized reading'  (duration: 212.157189ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:27.938056Z","caller":"traceutil/trace.go:171","msg":"trace[901589202] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:24676; }","duration":"210.921636ms","start":"2026-05-18T01:27:27.727111Z","end":"2026-05-18T01:27:27.938033Z","steps":["trace[901589202] 'agreement among raft nodes before linearized reading'  (duration: 210.788013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:27.938213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.587356ms","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-05-18T01:27:27.938295Z","caller":"traceutil/trace.go:171","msg":"trace[512913946] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24676; }","duration":"205.705548ms","start":"2026-05-18T01:27:27.732561Z","end":"2026-05-18T01:27:27.938267Z","steps":["trace[512913946] 'agreement among raft nodes before linearized reading'  (duration: 205.520415ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:28.35964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.622598ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101201229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24666 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:28.359775Z","caller":"traceutil/trace.go:171","msg":"trace[445316592] transaction","detail":"{read_only:false; response_revision:24680; number_of_response:1; }","duration":"229.455155ms","start":"2026-05-18T01:27:28.130294Z","end":"2026-05-18T01:27:28.359749Z","steps":["trace[445316592] 'process raft request'  (duration: 49.621653ms)","trace[445316592] 'compare'  (duration: 179.454575ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:28.386257Z","caller":"traceutil/trace.go:171","msg":"trace[613038082] linearizableReadLoop","detail":"{readStateIndex:25493; appliedIndex:25490; }","duration":"241.113743ms","start":"2026-05-18T01:27:28.145119Z","end":"2026-05-18T01:27:28.386233Z","steps":["trace[613038082] 'read index received'  (duration: 34.806614ms)","trace[613038082] 'applied index is now lower than readState.Index'  (duration: 206.305639ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:28.386301Z","caller":"traceutil/trace.go:171","msg":"trace[1916063565] transaction","detail":"{read_only:false; response_revision:24681; number_of_response:1; }","duration":"255.330981ms","start":"2026-05-18T01:27:28.130937Z","end":"2026-05-18T01:27:28.386268Z","steps":["trace[1916063565] 'process raft request'  (duration: 255.087227ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:28.386387Z","caller":"traceutil/trace.go:171","msg":"trace[2131071590] transaction","detail":"{read_only:false; response_revision:24682; number_of_response:1; }","duration":"255.23792ms","start":"2026-05-18T01:27:28.131139Z","end":"2026-05-18T01:27:28.386377Z","steps":["trace[2131071590] 'process raft request'  (duration: 255.043847ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:28.386678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.543262ms","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-05-18T01:27:28.386721Z","caller":"traceutil/trace.go:171","msg":"trace[328902074] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24682; }","duration":"241.624364ms","start":"2026-05-18T01:27:28.145082Z","end":"2026-05-18T01:27:28.386707Z","steps":["trace[328902074] 'agreement among raft nodes before linearized reading'  (duration: 241.43802ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:28.387031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.558357ms","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-05-18T01:27:28.387084Z","caller":"traceutil/trace.go:171","msg":"trace[1628972723] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:24682; }","duration":"179.653349ms","start":"2026-05-18T01:27:28.207416Z","end":"2026-05-18T01:27:28.38707Z","steps":["trace[1628972723] 'agreement among raft nodes before linearized reading'  (duration: 179.478846ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:28.543874Z","caller":"traceutil/trace.go:171","msg":"trace[2006254747] linearizableReadLoop","detail":"{readStateIndex:25494; appliedIndex:25493; }","duration":"150.926029ms","start":"2026-05-18T01:27:28.392926Z","end":"2026-05-18T01:27:28.543852Z","steps":["trace[2006254747] 'read index received'  (duration: 120.228081ms)","trace[2006254747] 'applied index is now lower than readState.Index'  (duration: 30.697018ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:28.543952Z","caller":"traceutil/trace.go:171","msg":"trace[1832947812] transaction","detail":"{read_only:false; response_revision:24683; number_of_response:1; }","duration":"151.940718ms","start":"2026-05-18T01:27:28.391948Z","end":"2026-05-18T01:27:28.543889Z","steps":["trace[1832947812] 'process raft request'  (duration: 121.110649ms)","trace[1832947812] 'compare'  (duration: 30.634846ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:28.544264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.01994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:27:28.544354Z","caller":"traceutil/trace.go:171","msg":"trace[1108946618] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24684; }","duration":"127.163892ms","start":"2026-05-18T01:27:28.417167Z","end":"2026-05-18T01:27:28.544331Z","steps":["trace[1108946618] 'agreement among raft nodes before linearized reading'  (duration: 127.01869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:28.544495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.1528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0937791e-8b62-4707-8d8f-54c15f325a57\" ","response":"range_response_count:1 size:3761"}
{"level":"info","ts":"2026-05-18T01:27:28.544654Z","caller":"traceutil/trace.go:171","msg":"trace[380105043] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0937791e-8b62-4707-8d8f-54c15f325a57; range_end:; response_count:1; response_revision:24684; }","duration":"145.359264ms","start":"2026-05-18T01:27:28.399262Z","end":"2026-05-18T01:27:28.544621Z","steps":["trace[380105043] 'agreement among raft nodes before linearized reading'  (duration: 144.865505ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:28.544725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.781764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"}
{"level":"info","ts":"2026-05-18T01:27:28.544809Z","caller":"traceutil/trace.go:171","msg":"trace[467124189] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24684; }","duration":"151.891476ms","start":"2026-05-18T01:27:28.392904Z","end":"2026-05-18T01:27:28.544795Z","steps":["trace[467124189] 'agreement among raft nodes before linearized reading'  (duration: 151.083861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:29.21925Z","caller":"traceutil/trace.go:171","msg":"trace[46249911] transaction","detail":"{read_only:false; response_revision:24685; number_of_response:1; }","duration":"148.096005ms","start":"2026-05-18T01:27:29.071126Z","end":"2026-05-18T01:27:29.219222Z","steps":["trace[46249911] 'process raft request'  (duration: 147.876921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:29.38983Z","caller":"traceutil/trace.go:171","msg":"trace[1900492516] transaction","detail":"{read_only:false; response_revision:24687; number_of_response:1; }","duration":"299.412201ms","start":"2026-05-18T01:27:29.090391Z","end":"2026-05-18T01:27:29.389803Z","steps":["trace[1900492516] 'process raft request'  (duration: 299.36405ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:29.389884Z","caller":"traceutil/trace.go:171","msg":"trace[435653481] transaction","detail":"{read_only:false; response_revision:24686; number_of_response:1; }","duration":"299.976721ms","start":"2026-05-18T01:27:29.089863Z","end":"2026-05-18T01:27:29.38984Z","steps":["trace[435653481] 'process raft request'  (duration: 299.754137ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:29.39015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:27:29.089833Z","time spent":"300.171326ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24672 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-18T01:27:32.087148Z","caller":"traceutil/trace.go:171","msg":"trace[2063862035] transaction","detail":"{read_only:false; response_revision:24704; number_of_response:1; }","duration":"128.71853ms","start":"2026-05-18T01:27:31.958402Z","end":"2026-05-18T01:27:32.08712Z","steps":["trace[2063862035] 'process raft request'  (duration: 128.551307ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:34.687655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.334175ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101201373 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24713 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:27:34.687825Z","caller":"traceutil/trace.go:171","msg":"trace[1430373459] transaction","detail":"{read_only:false; response_revision:24744; number_of_response:1; }","duration":"123.658326ms","start":"2026-05-18T01:27:34.564151Z","end":"2026-05-18T01:27:34.68781Z","steps":["trace[1430373459] 'process raft request'  (duration: 123.596334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:34.687991Z","caller":"traceutil/trace.go:171","msg":"trace[70905566] linearizableReadLoop","detail":"{readStateIndex:25556; appliedIndex:25555; }","duration":"167.777796ms","start":"2026-05-18T01:27:34.520195Z","end":"2026-05-18T01:27:34.687973Z","steps":["trace[70905566] 'read index received'  (duration: 65.062114ms)","trace[70905566] 'applied index is now lower than readState.Index'  (duration: 102.714042ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:27:34.688102Z","caller":"traceutil/trace.go:171","msg":"trace[1277315105] transaction","detail":"{read_only:false; response_revision:24743; number_of_response:1; }","duration":"279.917605ms","start":"2026-05-18T01:27:34.408168Z","end":"2026-05-18T01:27:34.688085Z","steps":["trace[1277315105] 'process raft request'  (duration: 177.07888ms)","trace[1277315105] 'compare'  (duration: 101.818756ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:34.688256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.594554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:27:34.688292Z","caller":"traceutil/trace.go:171","msg":"trace[1553391715] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:24744; }","duration":"166.659954ms","start":"2026-05-18T01:27:34.521621Z","end":"2026-05-18T01:27:34.688281Z","steps":["trace[1553391715] 'agreement among raft nodes before linearized reading'  (duration: 166.590823ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:34.688468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.275625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-18T01:27:34.688502Z","caller":"traceutil/trace.go:171","msg":"trace[1041906507] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:24744; }","duration":"168.358056ms","start":"2026-05-18T01:27:34.520136Z","end":"2026-05-18T01:27:34.688494Z","steps":["trace[1041906507] 'agreement among raft nodes before linearized reading'  (duration: 168.264314ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:27:34.689067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.149875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-18T01:27:34.689104Z","caller":"traceutil/trace.go:171","msg":"trace[910147862] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24744; }","duration":"107.246216ms","start":"2026-05-18T01:27:34.581849Z","end":"2026-05-18T01:27:34.689095Z","steps":["trace[910147862] 'agreement among raft nodes before linearized reading'  (duration: 107.158195ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:34.874655Z","caller":"traceutil/trace.go:171","msg":"trace[2026232173] linearizableReadLoop","detail":"{readStateIndex:25558; appliedIndex:25557; }","duration":"180.533455ms","start":"2026-05-18T01:27:34.694088Z","end":"2026-05-18T01:27:34.874622Z","steps":["trace[2026232173] 'read index received'  (duration: 127.291294ms)","trace[2026232173] 'applied index is now lower than readState.Index'  (duration: 53.240181ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:27:34.875159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.056586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0937791e-8b62-4707-8d8f-54c15f325a57\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-18T01:27:34.875212Z","caller":"traceutil/trace.go:171","msg":"trace[223670378] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0937791e-8b62-4707-8d8f-54c15f325a57; range_end:; response_count:1; response_revision:24744; }","duration":"181.178338ms","start":"2026-05-18T01:27:34.694018Z","end":"2026-05-18T01:27:34.875196Z","steps":["trace[223670378] 'agreement among raft nodes before linearized reading'  (duration: 181.003834ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:34.883186Z","caller":"traceutil/trace.go:171","msg":"trace[604251743] transaction","detail":"{read_only:false; response_revision:24745; number_of_response:1; }","duration":"188.916254ms","start":"2026-05-18T01:27:34.694255Z","end":"2026-05-18T01:27:34.883171Z","steps":["trace[604251743] 'process raft request'  (duration: 188.321872ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:27:34.883789Z","caller":"traceutil/trace.go:171","msg":"trace[1407938186] transaction","detail":"{read_only:false; response_revision:24746; number_of_response:1; }","duration":"182.771317ms","start":"2026-05-18T01:27:34.701005Z","end":"2026-05-18T01:27:34.883777Z","steps":["trace[1407938186] 'process raft request'  (duration: 181.875109ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:00.678397Z","caller":"traceutil/trace.go:171","msg":"trace[1509917793] transaction","detail":"{read_only:false; response_revision:24958; number_of_response:1; }","duration":"124.058543ms","start":"2026-05-18T01:28:00.554242Z","end":"2026-05-18T01:28:00.6783Z","steps":["trace[1509917793] 'process raft request'  (duration: 57.223366ms)","trace[1509917793] 'compare'  (duration: 66.194185ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:00.950912Z","caller":"traceutil/trace.go:171","msg":"trace[532210719] transaction","detail":"{read_only:false; response_revision:24959; number_of_response:1; }","duration":"169.470517ms","start":"2026-05-18T01:28:00.78141Z","end":"2026-05-18T01:28:00.950881Z","steps":["trace[532210719] 'process raft request'  (duration: 169.262573ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:00.953385Z","caller":"traceutil/trace.go:171","msg":"trace[443072166] transaction","detail":"{read_only:false; response_revision:24960; number_of_response:1; }","duration":"167.938008ms","start":"2026-05-18T01:28:00.785425Z","end":"2026-05-18T01:28:00.953363Z","steps":["trace[443072166] 'process raft request'  (duration: 167.676743ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:00.953353Z","caller":"traceutil/trace.go:171","msg":"trace[288336288] linearizableReadLoop","detail":"{readStateIndex:25779; appliedIndex:25777; }","duration":"126.661892ms","start":"2026-05-18T01:28:00.826653Z","end":"2026-05-18T01:28:00.953315Z","steps":["trace[288336288] 'read index received'  (duration: 124.011252ms)","trace[288336288] 'applied index is now lower than readState.Index'  (duration: 2.64876ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:00.953521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.837165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:00.953608Z","caller":"traceutil/trace.go:171","msg":"trace[1746248108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24960; }","duration":"126.943817ms","start":"2026-05-18T01:28:00.826645Z","end":"2026-05-18T01:28:00.953589Z","steps":["trace[1746248108] 'agreement among raft nodes before linearized reading'  (duration: 126.797804ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:05.110505Z","caller":"traceutil/trace.go:171","msg":"trace[243828163] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"140.989872ms","start":"2026-05-18T01:28:04.969493Z","end":"2026-05-18T01:28:05.110483Z","steps":["trace[243828163] 'process raft request'  (duration: 138.311802ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:05.110728Z","caller":"traceutil/trace.go:171","msg":"trace[151448269] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"137.913844ms","start":"2026-05-18T01:28:04.972808Z","end":"2026-05-18T01:28:05.110721Z","steps":["trace[151448269] 'process raft request'  (duration: 137.617948ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:06.760417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.915417ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101202021 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24983 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:28:06.760689Z","caller":"traceutil/trace.go:171","msg":"trace[1738659151] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"439.013876ms","start":"2026-05-18T01:28:06.321657Z","end":"2026-05-18T01:28:06.760671Z","steps":["trace[1738659151] 'process raft request'  (duration: 438.968755ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:06.760769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:06.321649Z","time spent":"439.083557ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24984 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-18T01:28:06.760841Z","caller":"traceutil/trace.go:171","msg":"trace[1625637170] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"440.055716ms","start":"2026-05-18T01:28:06.320755Z","end":"2026-05-18T01:28:06.760811Z","steps":["trace[1625637170] 'process raft request'  (duration: 136.617219ms)","trace[1625637170] 'compare'  (duration: 302.639052ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:06.761012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:06.320729Z","time spent":"440.190188ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24983 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-18T01:28:06.761057Z","caller":"traceutil/trace.go:171","msg":"trace[716993480] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"440.236759ms","start":"2026-05-18T01:28:06.320807Z","end":"2026-05-18T01:28:06.761044Z","steps":["trace[716993480] 'process raft request'  (duration: 439.73475ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:06.761383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:06.320795Z","time spent":"440.537544ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24985 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-18T01:28:06.903661Z","caller":"traceutil/trace.go:171","msg":"trace[2001928805] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"204.625888ms","start":"2026-05-18T01:28:06.698981Z","end":"2026-05-18T01:28:06.903607Z","steps":["trace[2001928805] 'process raft request'  (duration: 204.525246ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:06.903684Z","caller":"traceutil/trace.go:171","msg":"trace[753842137] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"406.346541ms","start":"2026-05-18T01:28:06.497264Z","end":"2026-05-18T01:28:06.903611Z","steps":["trace[753842137] 'process raft request'  (duration: 387.492366ms)","trace[753842137] 'compare'  (duration: 18.623471ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:06.903961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:06.497244Z","time spent":"406.572146ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24986 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-18T01:28:07.117678Z","caller":"traceutil/trace.go:171","msg":"trace[693931597] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"193.57793ms","start":"2026-05-18T01:28:06.924081Z","end":"2026-05-18T01:28:07.117659Z","steps":["trace[693931597] 'process raft request'  (duration: 123.781227ms)","trace[693931597] 'compare'  (duration: 69.698251ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:07.460027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.687778ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101202028 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24990 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:28:07.460774Z","caller":"traceutil/trace.go:171","msg":"trace[134599524] transaction","detail":"{read_only:false; response_revision:25005; number_of_response:1; }","duration":"344.193093ms","start":"2026-05-18T01:28:07.116557Z","end":"2026-05-18T01:28:07.46075Z","steps":["trace[134599524] 'process raft request'  (duration: 162.635758ms)","trace[134599524] 'compare'  (duration: 180.404323ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:07.460893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:07.116489Z","time spent":"344.367717ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24990 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-18T01:28:07.622718Z","caller":"traceutil/trace.go:171","msg":"trace[632617261] linearizableReadLoop","detail":"{readStateIndex:25826; appliedIndex:25824; }","duration":"501.243136ms","start":"2026-05-18T01:28:07.121444Z","end":"2026-05-18T01:28:07.622688Z","steps":["trace[632617261] 'read index received'  (duration: 157.814107ms)","trace[632617261] 'applied index is now lower than readState.Index'  (duration: 343.427609ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:07.622809Z","caller":"traceutil/trace.go:171","msg":"trace[30146064] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"505.287333ms","start":"2026-05-18T01:28:07.117453Z","end":"2026-05-18T01:28:07.62274Z","steps":["trace[30146064] 'process raft request'  (duration: 475.307549ms)","trace[30146064] 'compare'  (duration: 29.697128ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:07.622911Z","caller":"traceutil/trace.go:171","msg":"trace[451523668] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"452.607502ms","start":"2026-05-18T01:28:07.170223Z","end":"2026-05-18T01:28:07.622831Z","steps":["trace[451523668] 'process raft request'  (duration: 452.363647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:07.623073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:07.117426Z","time spent":"505.499217ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24991 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-18T01:28:07.623128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.663154ms","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":"warn","ts":"2026-05-18T01:28:07.62321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:07.170184Z","time spent":"452.872797ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24966 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-18T01:28:07.623228Z","caller":"traceutil/trace.go:171","msg":"trace[153705809] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25008; }","duration":"501.829067ms","start":"2026-05-18T01:28:07.121368Z","end":"2026-05-18T01:28:07.623197Z","steps":["trace[153705809] 'agreement among raft nodes before linearized reading'  (duration: 501.46013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:07.623291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:07.121338Z","time spent":"501.936339ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-18T01:28:07.623278Z","caller":"traceutil/trace.go:171","msg":"trace[1095105214] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"279.093298ms","start":"2026-05-18T01:28:07.344139Z","end":"2026-05-18T01:28:07.623233Z","steps":["trace[1095105214] 'process raft request'  (duration: 278.509657ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:07.623422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.76011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-18T01:28:07.623417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.955618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:07.623478Z","caller":"traceutil/trace.go:171","msg":"trace[2010880776] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:25010; }","duration":"238.897462ms","start":"2026-05-18T01:28:07.384563Z","end":"2026-05-18T01:28:07.62346Z","steps":["trace[2010880776] 'agreement among raft nodes before linearized reading'  (duration: 238.799021ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:07.623532Z","caller":"traceutil/trace.go:171","msg":"trace[1918038765] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:25010; }","duration":"311.123511ms","start":"2026-05-18T01:28:07.312379Z","end":"2026-05-18T01:28:07.623502Z","steps":["trace[1918038765] 'agreement among raft nodes before linearized reading'  (duration: 310.841346ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:07.623533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.932803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-18T01:28:07.62359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:07.312359Z","time spent":"311.216603ms","remote":"127.0.0.1:40142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":142,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true "}
{"level":"info","ts":"2026-05-18T01:28:07.623645Z","caller":"traceutil/trace.go:171","msg":"trace[41564398] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:25010; }","duration":"289.114256ms","start":"2026-05-18T01:28:07.334506Z","end":"2026-05-18T01:28:07.62362Z","steps":["trace[41564398] 'agreement among raft nodes before linearized reading'  (duration: 288.904173ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:07.896332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.970631ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101202037 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24992 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:28:07.896749Z","caller":"traceutil/trace.go:171","msg":"trace[561597509] transaction","detail":"{read_only:false; response_revision:25012; number_of_response:1; }","duration":"266.014212ms","start":"2026-05-18T01:28:07.630675Z","end":"2026-05-18T01:28:07.896689Z","steps":["trace[561597509] 'process raft request'  (duration: 265.805028ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:07.896949Z","caller":"traceutil/trace.go:171","msg":"trace[1934956347] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"267.842556ms","start":"2026-05-18T01:28:07.62905Z","end":"2026-05-18T01:28:07.896893Z","steps":["trace[1934956347] 'process raft request'  (duration: 126.192983ms)","trace[1934956347] 'compare'  (duration: 140.792807ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:08.225544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.436903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:08.225684Z","caller":"traceutil/trace.go:171","msg":"trace[1411165698] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25012; }","duration":"105.631387ms","start":"2026-05-18T01:28:08.120031Z","end":"2026-05-18T01:28:08.225662Z","steps":["trace[1411165698] 'count revisions from in-memory index tree'  (duration: 105.334551ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:08.427751Z","caller":"traceutil/trace.go:171","msg":"trace[41866691] transaction","detail":"{read_only:false; response_revision:25013; number_of_response:1; }","duration":"102.105781ms","start":"2026-05-18T01:28:08.325623Z","end":"2026-05-18T01:28:08.427729Z","steps":["trace[41866691] 'process raft request'  (duration: 101.962729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:08.966278Z","caller":"traceutil/trace.go:171","msg":"trace[1050103430] transaction","detail":"{read_only:false; response_revision:25015; number_of_response:1; }","duration":"194.842994ms","start":"2026-05-18T01:28:08.771404Z","end":"2026-05-18T01:28:08.966247Z","steps":["trace[1050103430] 'process raft request'  (duration: 157.979171ms)","trace[1050103430] 'compare'  (duration: 36.592358ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:08.966685Z","caller":"traceutil/trace.go:171","msg":"trace[879688181] transaction","detail":"{read_only:false; response_revision:25016; number_of_response:1; }","duration":"194.748522ms","start":"2026-05-18T01:28:08.771898Z","end":"2026-05-18T01:28:08.966646Z","steps":["trace[879688181] 'process raft request'  (duration: 194.260923ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:08.966857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.190505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:08.966977Z","caller":"traceutil/trace.go:171","msg":"trace[710264461] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:25016; }","duration":"174.382149ms","start":"2026-05-18T01:28:08.792568Z","end":"2026-05-18T01:28:08.96695Z","steps":["trace[710264461] 'agreement among raft nodes before linearized reading'  (duration: 174.150805ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:08.966664Z","caller":"traceutil/trace.go:171","msg":"trace[434315503] linearizableReadLoop","detail":"{readStateIndex:25836; appliedIndex:25833; }","duration":"173.985792ms","start":"2026-05-18T01:28:08.792614Z","end":"2026-05-18T01:28:08.9666Z","steps":["trace[434315503] 'read index received'  (duration: 32.312848ms)","trace[434315503] 'applied index is now lower than readState.Index'  (duration: 141.668874ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:09.063397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.169271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:28:09.063489Z","caller":"traceutil/trace.go:171","msg":"trace[1267848179] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:25018; }","duration":"170.281993ms","start":"2026-05-18T01:28:08.893189Z","end":"2026-05-18T01:28:09.063471Z","steps":["trace[1267848179] 'agreement among raft nodes before linearized reading'  (duration: 170.068249ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.063803Z","caller":"traceutil/trace.go:171","msg":"trace[1518899407] transaction","detail":"{read_only:false; response_revision:25017; number_of_response:1; }","duration":"154.321652ms","start":"2026-05-18T01:28:08.909472Z","end":"2026-05-18T01:28:09.063793Z","steps":["trace[1518899407] 'process raft request'  (duration: 153.606628ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.063906Z","caller":"traceutil/trace.go:171","msg":"trace[1350816088] transaction","detail":"{read_only:false; response_revision:25018; number_of_response:1; }","duration":"153.987376ms","start":"2026-05-18T01:28:08.909912Z","end":"2026-05-18T01:28:09.063899Z","steps":["trace[1350816088] 'process raft request'  (duration: 153.288443ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.754819Z","caller":"traceutil/trace.go:171","msg":"trace[1438106313] linearizableReadLoop","detail":"{readStateIndex:25839; appliedIndex:25838; }","duration":"267.96133ms","start":"2026-05-18T01:28:09.486821Z","end":"2026-05-18T01:28:09.754782Z","steps":["trace[1438106313] 'read index received'  (duration: 267.900648ms)","trace[1438106313] 'applied index is now lower than readState.Index'  (duration: 59.262µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:09.754932Z","caller":"traceutil/trace.go:171","msg":"trace[543863773] transaction","detail":"{read_only:false; response_revision:25019; number_of_response:1; }","duration":"288.344452ms","start":"2026-05-18T01:28:09.466532Z","end":"2026-05-18T01:28:09.754876Z","steps":["trace[543863773] 'process raft request'  (duration: 288.095808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:09.75507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.224435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-18T01:28:09.755149Z","caller":"traceutil/trace.go:171","msg":"trace[1353894175] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:25019; }","duration":"268.393588ms","start":"2026-05-18T01:28:09.486725Z","end":"2026-05-18T01:28:09.755118Z","steps":["trace[1353894175] 'agreement among raft nodes before linearized reading'  (duration: 268.189674ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.759596Z","caller":"traceutil/trace.go:171","msg":"trace[1613118072] transaction","detail":"{read_only:false; response_revision:25020; number_of_response:1; }","duration":"129.351382ms","start":"2026-05-18T01:28:09.630232Z","end":"2026-05-18T01:28:09.759583Z","steps":["trace[1613118072] 'process raft request'  (duration: 128.385954ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.759736Z","caller":"traceutil/trace.go:171","msg":"trace[1579571280] transaction","detail":"{read_only:false; response_revision:25021; number_of_response:1; }","duration":"129.127899ms","start":"2026-05-18T01:28:09.630599Z","end":"2026-05-18T01:28:09.759727Z","steps":["trace[1579571280] 'process raft request'  (duration: 128.152311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.75981Z","caller":"traceutil/trace.go:171","msg":"trace[665164153] transaction","detail":"{read_only:false; response_revision:25022; number_of_response:1; }","duration":"129.051797ms","start":"2026-05-18T01:28:09.630753Z","end":"2026-05-18T01:28:09.759805Z","steps":["trace[665164153] 'process raft request'  (duration: 128.056989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:09.759879Z","caller":"traceutil/trace.go:171","msg":"trace[2031723580] transaction","detail":"{read_only:false; response_revision:25023; number_of_response:1; }","duration":"128.17607ms","start":"2026-05-18T01:28:09.631698Z","end":"2026-05-18T01:28:09.759874Z","steps":["trace[2031723580] 'process raft request'  (duration: 127.142361ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:09.866168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.276377ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101202063 > lease_revoke:<id:56469e3886ad8b74>","response":"size:29"}
{"level":"info","ts":"2026-05-18T01:28:09.866286Z","caller":"traceutil/trace.go:171","msg":"trace[950269411] linearizableReadLoop","detail":"{readStateIndex:25844; appliedIndex:25839; }","duration":"111.389344ms","start":"2026-05-18T01:28:09.754879Z","end":"2026-05-18T01:28:09.866268Z","steps":["trace[950269411] 'read index received'  (duration: 3.559507ms)","trace[950269411] 'applied index is now lower than readState.Index'  (duration: 107.828327ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:09.866686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.048916ms","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-05-18T01:28:09.866718Z","caller":"traceutil/trace.go:171","msg":"trace[817498423] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25023; }","duration":"280.129638ms","start":"2026-05-18T01:28:09.586577Z","end":"2026-05-18T01:28:09.866707Z","steps":["trace[817498423] 'agreement among raft nodes before linearized reading'  (duration: 279.73041ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:10.247258Z","caller":"traceutil/trace.go:171","msg":"trace[2032415810] transaction","detail":"{read_only:false; response_revision:25024; number_of_response:1; }","duration":"330.605768ms","start":"2026-05-18T01:28:09.916616Z","end":"2026-05-18T01:28:10.247221Z","steps":["trace[2032415810] 'process raft request'  (duration: 330.386104ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:10.247464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:09.916583Z","time spent":"330.771691ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25011 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-18T01:28:10.43441Z","caller":"traceutil/trace.go:171","msg":"trace[2106354121] linearizableReadLoop","detail":"{readStateIndex:25846; appliedIndex:25844; }","duration":"448.863082ms","start":"2026-05-18T01:28:09.98553Z","end":"2026-05-18T01:28:10.434393Z","steps":["trace[2106354121] 'read index received'  (duration: 261.567559ms)","trace[2106354121] 'applied index is now lower than readState.Index'  (duration: 187.294883ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:10.434511Z","caller":"traceutil/trace.go:171","msg":"trace[1095344196] transaction","detail":"{read_only:false; response_revision:25025; number_of_response:1; }","duration":"513.160001ms","start":"2026-05-18T01:28:09.921344Z","end":"2026-05-18T01:28:10.434504Z","steps":["trace[1095344196] 'process raft request'  (duration: 470.346916ms)","trace[1095344196] 'compare'  (duration: 42.139542ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:10.434587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:09.921319Z","time spent":"513.207971ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25012 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-18T01:28:10.434693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.160616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:10.434793Z","caller":"traceutil/trace.go:171","msg":"trace[1803267289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25025; }","duration":"449.312149ms","start":"2026-05-18T01:28:09.985453Z","end":"2026-05-18T01:28:10.434765Z","steps":["trace[1803267289] 'agreement among raft nodes before linearized reading'  (duration: 449.137016ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:10.434853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:09.985422Z","time spent":"449.417772ms","remote":"127.0.0.1:50228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-18T01:28:10.434696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.782369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-05-18T01:28:10.435106Z","caller":"traceutil/trace.go:171","msg":"trace[649424180] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:25025; }","duration":"199.212266ms","start":"2026-05-18T01:28:10.235882Z","end":"2026-05-18T01:28:10.435094Z","steps":["trace[649424180] 'agreement among raft nodes before linearized reading'  (duration: 198.692257ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:12.866682Z","caller":"traceutil/trace.go:171","msg":"trace[1839244203] linearizableReadLoop","detail":"{readStateIndex:25861; appliedIndex:25860; }","duration":"122.985592ms","start":"2026-05-18T01:28:12.743668Z","end":"2026-05-18T01:28:12.866653Z","steps":["trace[1839244203] 'read index received'  (duration: 122.740147ms)","trace[1839244203] 'applied index is now lower than readState.Index'  (duration: 244.454µs)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:12.866854Z","caller":"traceutil/trace.go:171","msg":"trace[578607268] transaction","detail":"{read_only:false; response_revision:25040; number_of_response:1; }","duration":"236.867114ms","start":"2026-05-18T01:28:12.629939Z","end":"2026-05-18T01:28:12.866806Z","steps":["trace[578607268] 'process raft request'  (duration: 236.533687ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:12.866974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.298389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-05-18T01:28:12.867016Z","caller":"traceutil/trace.go:171","msg":"trace[364890342] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:25040; }","duration":"123.38936ms","start":"2026-05-18T01:28:12.743615Z","end":"2026-05-18T01:28:12.867004Z","steps":["trace[364890342] 'agreement among raft nodes before linearized reading'  (duration: 123.197886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:13.289771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.675659ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101202124 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25028 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:28:13.289929Z","caller":"traceutil/trace.go:171","msg":"trace[1746400818] transaction","detail":"{read_only:false; response_revision:25043; number_of_response:1; }","duration":"295.789263ms","start":"2026-05-18T01:28:12.99411Z","end":"2026-05-18T01:28:13.289899Z","steps":["trace[1746400818] 'process raft request'  (duration: 132.853298ms)","trace[1746400818] 'compare'  (duration: 162.428834ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:13.368201Z","caller":"traceutil/trace.go:171","msg":"trace[1692747620] linearizableReadLoop","detail":"{readStateIndex:25867; appliedIndex:25864; }","duration":"100.969249ms","start":"2026-05-18T01:28:13.267198Z","end":"2026-05-18T01:28:13.368167Z","steps":["trace[1692747620] 'read index received'  (duration: 100.526171ms)","trace[1692747620] 'applied index is now lower than readState.Index'  (duration: 441.898µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:13.368402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.171043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:13.368448Z","caller":"traceutil/trace.go:171","msg":"trace[711611948] transaction","detail":"{read_only:false; response_revision:25045; number_of_response:1; }","duration":"291.88888ms","start":"2026-05-18T01:28:13.076541Z","end":"2026-05-18T01:28:13.36843Z","steps":["trace[711611948] 'process raft request'  (duration: 291.501352ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:13.368499Z","caller":"traceutil/trace.go:171","msg":"trace[690502064] transaction","detail":"{read_only:false; response_revision:25046; number_of_response:1; }","duration":"290.456273ms","start":"2026-05-18T01:28:13.078033Z","end":"2026-05-18T01:28:13.36849Z","steps":["trace[690502064] 'process raft request'  (duration: 290.080405ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:13.36846Z","caller":"traceutil/trace.go:171","msg":"trace[1675921014] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25046; }","duration":"101.267395ms","start":"2026-05-18T01:28:13.267175Z","end":"2026-05-18T01:28:13.368442Z","steps":["trace[1675921014] 'agreement among raft nodes before linearized reading'  (duration: 101.128552ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:13.368787Z","caller":"traceutil/trace.go:171","msg":"trace[1426749053] transaction","detail":"{read_only:false; response_revision:25044; number_of_response:1; }","duration":"372.871582ms","start":"2026-05-18T01:28:12.995865Z","end":"2026-05-18T01:28:13.368737Z","steps":["trace[1426749053] 'process raft request'  (duration: 371.973785ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:13.369097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:12.995826Z","time spent":"373.097166ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25029 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-18T01:28:13.889984Z","caller":"traceutil/trace.go:171","msg":"trace[246177296] transaction","detail":"{read_only:false; response_revision:25047; number_of_response:1; }","duration":"121.413844ms","start":"2026-05-18T01:28:13.768536Z","end":"2026-05-18T01:28:13.88995Z","steps":["trace[246177296] 'process raft request'  (duration: 121.16813ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:14.039821Z","caller":"traceutil/trace.go:171","msg":"trace[1311252561] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"260.894167ms","start":"2026-05-18T01:28:13.77886Z","end":"2026-05-18T01:28:14.039754Z","steps":["trace[1311252561] 'process raft request'  (duration: 260.404398ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:14.039947Z","caller":"traceutil/trace.go:171","msg":"trace[663056267] transaction","detail":"{read_only:false; response_revision:25050; number_of_response:1; }","duration":"260.657382ms","start":"2026-05-18T01:28:13.779258Z","end":"2026-05-18T01:28:14.039916Z","steps":["trace[663056267] 'process raft request'  (duration: 260.057271ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:14.039968Z","caller":"traceutil/trace.go:171","msg":"trace[1945315161] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"263.826042ms","start":"2026-05-18T01:28:13.776088Z","end":"2026-05-18T01:28:14.039914Z","steps":["trace[1945315161] 'process raft request'  (duration: 244.920527ms)","trace[1945315161] 'compare'  (duration: 18.08553ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:14.040851Z","caller":"traceutil/trace.go:171","msg":"trace[690238374] transaction","detail":"{read_only:false; response_revision:25051; number_of_response:1; }","duration":"259.53743ms","start":"2026-05-18T01:28:13.780737Z","end":"2026-05-18T01:28:14.040274Z","steps":["trace[690238374] 'process raft request'  (duration: 258.632904ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:14.648295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.185822ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202338101202138 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25037 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-18T01:28:14.648426Z","caller":"traceutil/trace.go:171","msg":"trace[1729546469] linearizableReadLoop","detail":"{readStateIndex:25874; appliedIndex:25873; }","duration":"195.462226ms","start":"2026-05-18T01:28:14.452943Z","end":"2026-05-18T01:28:14.648405Z","steps":["trace[1729546469] 'read index received'  (duration: 18.029329ms)","trace[1729546469] 'applied index is now lower than readState.Index'  (duration: 177.431157ms)"],"step_count":2}
{"level":"info","ts":"2026-05-18T01:28:14.648505Z","caller":"traceutil/trace.go:171","msg":"trace[892206495] transaction","detail":"{read_only:false; response_revision:25053; number_of_response:1; }","duration":"311.810304ms","start":"2026-05-18T01:28:14.336682Z","end":"2026-05-18T01:28:14.648493Z","steps":["trace[892206495] 'process raft request'  (duration: 134.311195ms)","trace[892206495] 'compare'  (duration: 176.897637ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-18T01:28:14.648557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T01:28:14.33666Z","time spent":"311.869716ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25037 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-18T01:28:14.648893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.920925ms","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-05-18T01:28:14.649108Z","caller":"traceutil/trace.go:171","msg":"trace[2049782254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25053; }","duration":"196.087308ms","start":"2026-05-18T01:28:14.452888Z","end":"2026-05-18T01:28:14.648976Z","steps":["trace[2049782254] 'agreement among raft nodes before linearized reading'  (duration: 195.725271ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:14.650409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.460859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:28:14.650469Z","caller":"traceutil/trace.go:171","msg":"trace[43270521] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25054; }","duration":"159.572411ms","start":"2026-05-18T01:28:14.490882Z","end":"2026-05-18T01:28:14.650454Z","steps":["trace[43270521] 'agreement among raft nodes before linearized reading'  (duration: 159.465399ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:14.650619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.124689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-18T01:28:14.650675Z","caller":"traceutil/trace.go:171","msg":"trace[1186820883] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:25054; }","duration":"128.22097ms","start":"2026-05-18T01:28:14.522439Z","end":"2026-05-18T01:28:14.65066Z","steps":["trace[1186820883] 'agreement among raft nodes before linearized reading'  (duration: 128.074347ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:14.650724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.458875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-18T01:28:14.650755Z","caller":"traceutil/trace.go:171","msg":"trace[1537464313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25054; }","duration":"145.528937ms","start":"2026-05-18T01:28:14.505216Z","end":"2026-05-18T01:28:14.650745Z","steps":["trace[1537464313] 'agreement among raft nodes before linearized reading'  (duration: 145.433725ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:18.871793Z","caller":"traceutil/trace.go:171","msg":"trace[44827307] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"125.43967ms","start":"2026-05-18T01:28:18.746312Z","end":"2026-05-18T01:28:18.871752Z","steps":["trace[44827307] 'process raft request'  (duration: 124.938131ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:18.887322Z","caller":"traceutil/trace.go:171","msg":"trace[215371139] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"140.197466ms","start":"2026-05-18T01:28:18.747082Z","end":"2026-05-18T01:28:18.887279Z","steps":["trace[215371139] 'process raft request'  (duration: 139.922631ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-18T01:28:19.150227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.196541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-18T01:28:19.150462Z","caller":"traceutil/trace.go:171","msg":"trace[1789113094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25084; }","duration":"136.499197ms","start":"2026-05-18T01:28:19.013934Z","end":"2026-05-18T01:28:19.150433Z","steps":["trace[1789113094] 'range keys from in-memory index tree'  (duration: 135.897415ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:28:19.257456Z","caller":"traceutil/trace.go:171","msg":"trace[195142350] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"101.942508ms","start":"2026-05-18T01:28:19.155476Z","end":"2026-05-18T01:28:19.257419Z","steps":["trace[195142350] 'process raft request'  (duration: 101.697493ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:29:55.610298Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006908.wal"}
{"level":"info","ts":"2026-05-18T01:30:11.219966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23338}
{"level":"info","ts":"2026-05-18T01:30:11.357909Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23338,"took":"131.947922ms","hash":3533999797,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":36110336,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-18T01:30:11.357975Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3533999797,"revision":23338,"compact-revision":20151}
{"level":"warn","ts":"2026-05-18T01:32:05.195927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.91281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-18T01:32:05.196038Z","caller":"traceutil/trace.go:171","msg":"trace[2002220469] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:27409; }","duration":"107.058892ms","start":"2026-05-18T01:32:05.088948Z","end":"2026-05-18T01:32:05.196007Z","steps":["trace[2002220469] 'count revisions from in-memory index tree'  (duration: 106.809968ms)"],"step_count":1}
{"level":"info","ts":"2026-05-18T01:35:11.226539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26229}
{"level":"info","ts":"2026-05-18T01:35:11.363227Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26229,"took":"132.897269ms","hash":2451957061,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":33259520,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-18T01:35:11.363318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2451957061,"revision":26229,"compact-revision":23338}
{"level":"info","ts":"2026-05-18T01:35:45.737389Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-18T01:35:45.743298Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-18T01:35:45.743477Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-18T01:40:11.232606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28823}
{"level":"info","ts":"2026-05-18T01:40:11.370789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28823,"took":"134.363564ms","hash":1576062492,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":30134272,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-18T01:40:11.370861Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1576062492,"revision":28823,"compact-revision":26229}
{"level":"info","ts":"2026-05-18T01:45:11.242537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31047}
{"level":"info","ts":"2026-05-18T01:45:11.366077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31047,"took":"117.973548ms","hash":560842368,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":31043584,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-18T01:45:11.366175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":560842368,"revision":31047,"compact-revision":28823}
{"level":"info","ts":"2026-05-18T01:50:11.248569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33309}
{"level":"info","ts":"2026-05-18T01:50:11.395998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33309,"took":"140.738035ms","hash":160205383,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":32129024,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-18T01:50:11.396078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":160205383,"revision":33309,"compact-revision":31047}
{"level":"info","ts":"2026-05-18T01:55:11.254579Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35602}
{"level":"info","ts":"2026-05-18T01:55:11.399659Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35602,"took":"140.80286ms","hash":2430313553,"current-db-size-bytes":58753024,"current-db-size":"59 MB","current-db-size-in-use-bytes":31002624,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-18T01:55:11.39974Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2430313553,"revision":35602,"compact-revision":33309}
{"level":"info","ts":"2026-05-18T01:57:16.114637Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-18T01:57:16.119166Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-18T01:57:16.119311Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}