{"level":"warn","ts":"2026-05-08T10:24:07.076317Z","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-08T10:24:07.076504Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.35:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.35:2380","--initial-cluster=instance=https://199.19.213.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.35: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-08T10:24:07.076582Z","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-08T10:24:07.076599Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.35:2380"]}
{"level":"info","ts":"2026-05-08T10:24:07.076622Z","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-08T10:24:07.07765Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"]}
{"level":"info","ts":"2026-05-08T10:24:07.077803Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.35: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-08T10:24:07.081492Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.324302ms"}
{"level":"info","ts":"2026-05-08T10:24:07.086412Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1606b245347dc08","cluster-id":"e68e205b85faf98a"}
{"level":"info","ts":"2026-05-08T10:24:07.086525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-08T10:24:07.086543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 0"}
{"level":"info","ts":"2026-05-08T10:24:07.086554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1606b245347dc08 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-08T10:24:07.08657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 1"}
{"level":"info","ts":"2026-05-08T10:24:07.086619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"}
{"level":"warn","ts":"2026-05-08T10:24:07.094462Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-08T10:24:07.095775Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-08T10:24:07.096622Z","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-08T10:24:07.099725Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1606b245347dc08","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-08T10:24:07.100083Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1606b245347dc08","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-08T10:24:07.100123Z","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-08T10:24:07.100275Z","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-08T10:24:07.100295Z","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-08T10:24:07.102291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"}
{"level":"info","ts":"2026-05-08T10:24:07.102902Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","added-peer-id":"d1606b245347dc08","added-peer-peer-urls":["https://199.19.213.35:2380"]}
{"level":"info","ts":"2026-05-08T10:24:07.105617Z","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-08T10:24:07.105749Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.35:2380"}
{"level":"info","ts":"2026-05-08T10:24:07.10593Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.35:2380"}
{"level":"info","ts":"2026-05-08T10:24:07.106054Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1606b245347dc08","initial-advertise-peer-urls":["https://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-08T10:24:07.106089Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-08T10:24:07.187184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-08T10:24:07.187277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-08T10:24:07.187321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgPreVoteResp from d1606b245347dc08 at term 1"}
{"level":"info","ts":"2026-05-08T10:24:07.187342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became candidate at term 2"}
{"level":"info","ts":"2026-05-08T10:24:07.187354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgVoteResp from d1606b245347dc08 at term 2"}
{"level":"info","ts":"2026-05-08T10:24:07.187372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became leader at term 2"}
{"level":"info","ts":"2026-05-08T10:24:07.187394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1606b245347dc08 elected leader d1606b245347dc08 at term 2"}
{"level":"info","ts":"2026-05-08T10:24:07.188289Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T10:24:07.189467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T10:24:07.189572Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T10:24:07.189892Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T10:24:07.190095Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T10:24:07.190163Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-08T10:24:07.1902Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-08T10:24:07.190199Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T10:24:07.193006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-08T10:24:07.189457Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1606b245347dc08","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.35:2379]}","request-path":"/0/members/d1606b245347dc08/attributes","cluster-id":"e68e205b85faf98a","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-08T10:24:07.193689Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.35:2379"}
{"level":"warn","ts":"2026-05-08T10:24:14.742372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.655892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-05-08T10:24:14.742518Z","caller":"traceutil/trace.go:171","msg":"trace[1955828770] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:284; }","duration":"127.879857ms","start":"2026-05-08T10:24:14.614611Z","end":"2026-05-08T10:24:14.742491Z","steps":["trace[1955828770] 'range keys from in-memory index tree'  (duration: 127.511509ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:24:25.388977Z","caller":"traceutil/trace.go:171","msg":"trace[946264988] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"214.239683ms","start":"2026-05-08T10:24:25.174702Z","end":"2026-05-08T10:24:25.388941Z","steps":["trace[946264988] 'process raft request'  (duration: 214.063009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:24:43.636238Z","caller":"traceutil/trace.go:171","msg":"trace[1265810955] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"115.256164ms","start":"2026-05-08T10:24:43.520944Z","end":"2026-05-08T10:24:43.6362Z","steps":["trace[1265810955] 'process raft request'  (duration: 114.640379ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:24:49.731175Z","caller":"traceutil/trace.go:171","msg":"trace[1164652245] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"177.893473ms","start":"2026-05-08T10:24:49.553236Z","end":"2026-05-08T10:24:49.731129Z","steps":["trace[1164652245] 'process raft request'  (duration: 177.696467ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:24:50.630945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.506233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fmrvt\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-08T10:24:50.631061Z","caller":"traceutil/trace.go:171","msg":"trace[303640298] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fmrvt; range_end:; response_count:1; response_revision:651; }","duration":"247.672327ms","start":"2026-05-08T10:24:50.38336Z","end":"2026-05-08T10:24:50.631032Z","steps":["trace[303640298] 'range keys from in-memory index tree'  (duration: 247.002691ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:24:50.853111Z","caller":"traceutil/trace.go:171","msg":"trace[757362211] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"190.532906ms","start":"2026-05-08T10:24:50.662545Z","end":"2026-05-08T10:24:50.853078Z","steps":["trace[757362211] 'read index received'  (duration: 190.2783ms)","trace[757362211] 'applied index is now lower than readState.Index'  (duration: 253.566µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:24:50.853223Z","caller":"traceutil/trace.go:171","msg":"trace[301418418] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"204.578975ms","start":"2026-05-08T10:24:50.648576Z","end":"2026-05-08T10:24:50.853154Z","steps":["trace[301418418] 'process raft request'  (duration: 204.243657ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:24:50.853364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.787602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.35\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-08T10:24:50.853411Z","caller":"traceutil/trace.go:171","msg":"trace[897485910] range","detail":"{range_begin:/registry/masterleases/199.19.213.35; range_end:; response_count:1; response_revision:652; }","duration":"190.887805ms","start":"2026-05-08T10:24:50.662511Z","end":"2026-05-08T10:24:50.853399Z","steps":["trace[897485910] 'agreement among raft nodes before linearized reading'  (duration: 190.744882ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:24:50.853606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.381156ms","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-08T10:24:50.853742Z","caller":"traceutil/trace.go:171","msg":"trace[2008290055] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"168.577931ms","start":"2026-05-08T10:24:50.685135Z","end":"2026-05-08T10:24:50.853713Z","steps":["trace[2008290055] 'agreement among raft nodes before linearized reading'  (duration: 168.14873ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:25:35.37858Z","caller":"traceutil/trace.go:171","msg":"trace[196835792] linearizableReadLoop","detail":"{readStateIndex:1196; appliedIndex:1195; }","duration":"104.18541ms","start":"2026-05-08T10:25:35.274366Z","end":"2026-05-08T10:25:35.378552Z","steps":["trace[196835792] 'read index received'  (duration: 103.977784ms)","trace[196835792] 'applied index is now lower than readState.Index'  (duration: 206.396µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:25:35.378744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.360954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:25:35.378682Z","caller":"traceutil/trace.go:171","msg":"trace[1516863408] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"150.187593ms","start":"2026-05-08T10:25:35.228435Z","end":"2026-05-08T10:25:35.378623Z","steps":["trace[1516863408] 'process raft request'  (duration: 149.860745ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:25:35.378784Z","caller":"traceutil/trace.go:171","msg":"trace[1552792318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1163; }","duration":"104.468957ms","start":"2026-05-08T10:25:35.274302Z","end":"2026-05-08T10:25:35.37877Z","steps":["trace[1552792318] 'agreement among raft nodes before linearized reading'  (duration: 104.385285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:25:51.6442Z","caller":"traceutil/trace.go:171","msg":"trace[1001470552] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"161.979908ms","start":"2026-05-08T10:25:51.482183Z","end":"2026-05-08T10:25:51.644163Z","steps":["trace[1001470552] 'process raft request'  (duration: 160.954323ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:25:59.004719Z","caller":"traceutil/trace.go:171","msg":"trace[1804585928] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"178.243301ms","start":"2026-05-08T10:25:58.826439Z","end":"2026-05-08T10:25:59.004682Z","steps":["trace[1804585928] 'process raft request'  (duration: 121.845806ms)","trace[1804585928] 'compare'  (duration: 56.233051ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:26:22.895852Z","caller":"traceutil/trace.go:171","msg":"trace[1813186088] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"148.241558ms","start":"2026-05-08T10:26:22.747568Z","end":"2026-05-08T10:26:22.89581Z","steps":["trace[1813186088] 'process raft request'  (duration: 129.573407ms)","trace[1813186088] 'compare'  (duration: 18.030386ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:26:23.078784Z","caller":"traceutil/trace.go:171","msg":"trace[801597583] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"173.996037ms","start":"2026-05-08T10:26:22.904747Z","end":"2026-05-08T10:26:23.078743Z","steps":["trace[801597583] 'process raft request'  (duration: 134.985971ms)","trace[801597583] 'compare'  (duration: 38.540873ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:26:36.479624Z","caller":"traceutil/trace.go:171","msg":"trace[664859473] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"163.869254ms","start":"2026-05-08T10:26:36.315725Z","end":"2026-05-08T10:26:36.479595Z","steps":["trace[664859473] 'process raft request'  (duration: 163.69071ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:27:07.305436Z","caller":"traceutil/trace.go:171","msg":"trace[747247981] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"137.044562ms","start":"2026-05-08T10:27:07.168347Z","end":"2026-05-08T10:27:07.305391Z","steps":["trace[747247981] 'read index received'  (duration: 136.720314ms)","trace[747247981] 'applied index is now lower than readState.Index'  (duration: 323.238µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:27:07.305511Z","caller":"traceutil/trace.go:171","msg":"trace[1770441444] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"141.777478ms","start":"2026-05-08T10:27:07.163691Z","end":"2026-05-08T10:27:07.305469Z","steps":["trace[1770441444] 'process raft request'  (duration: 141.45097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:27:07.305731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.359809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-08T10:27:07.305782Z","caller":"traceutil/trace.go:171","msg":"trace[136965785] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2129; }","duration":"137.458722ms","start":"2026-05-08T10:27:07.168308Z","end":"2026-05-08T10:27:07.305767Z","steps":["trace[136965785] 'agreement among raft nodes before linearized reading'  (duration: 137.276517ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:27:07.306139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.377885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-05-08T10:27:07.306217Z","caller":"traceutil/trace.go:171","msg":"trace[11641670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2129; }","duration":"113.502288ms","start":"2026-05-08T10:27:07.192698Z","end":"2026-05-08T10:27:07.306201Z","steps":["trace[11641670] 'agreement among raft nodes before linearized reading'  (duration: 113.280373ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:27:13.167666Z","caller":"traceutil/trace.go:171","msg":"trace[920005428] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"154.318359ms","start":"2026-05-08T10:27:13.01329Z","end":"2026-05-08T10:27:13.167609Z","steps":["trace[920005428] 'process raft request'  (duration: 154.075353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:27:13.572387Z","caller":"traceutil/trace.go:171","msg":"trace[1520145418] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"201.205229ms","start":"2026-05-08T10:27:13.37114Z","end":"2026-05-08T10:27:13.572345Z","steps":["trace[1520145418] 'process raft request'  (duration: 168.773187ms)","trace[1520145418] 'compare'  (duration: 32.264018ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:28:34.624666Z","caller":"traceutil/trace.go:171","msg":"trace[830575861] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"175.366599ms","start":"2026-05-08T10:28:34.449268Z","end":"2026-05-08T10:28:34.624634Z","steps":["trace[830575861] 'process raft request'  (duration: 175.159104ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:28:34.743384Z","caller":"traceutil/trace.go:171","msg":"trace[1725282214] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"218.489327ms","start":"2026-05-08T10:28:34.524841Z","end":"2026-05-08T10:28:34.743331Z","steps":["trace[1725282214] 'process raft request'  (duration: 217.334097ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:32:37.598223Z","caller":"traceutil/trace.go:171","msg":"trace[801567261] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"176.947226ms","start":"2026-05-08T10:32:37.421234Z","end":"2026-05-08T10:32:37.598182Z","steps":["trace[801567261] 'process raft request'  (duration: 176.717231ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:32:40.743025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.818547ms","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-08T10:32:40.743189Z","caller":"traceutil/trace.go:171","msg":"trace[739081868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5010; }","duration":"311.992502ms","start":"2026-05-08T10:32:40.431111Z","end":"2026-05-08T10:32:40.743104Z","steps":["trace[739081868] 'range keys from in-memory index tree'  (duration: 311.527101ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:32:40.743246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:32:40.43108Z","time spent":"312.152465ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-08T10:32:40.743471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.986222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-08T10:32:40.743526Z","caller":"traceutil/trace.go:171","msg":"trace[1961058364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5010; }","duration":"307.064584ms","start":"2026-05-08T10:32:40.436446Z","end":"2026-05-08T10:32:40.743511Z","steps":["trace[1961058364] 'range keys from in-memory index tree'  (duration: 306.347075ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:32:40.743559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:32:40.436436Z","time spent":"307.115455ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-08T10:32:52.849746Z","caller":"traceutil/trace.go:171","msg":"trace[2126636733] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"127.33789ms","start":"2026-05-08T10:32:52.722371Z","end":"2026-05-08T10:32:52.849709Z","steps":["trace[2126636733] 'process raft request'  (duration: 127.254178ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:32:52.850097Z","caller":"traceutil/trace.go:171","msg":"trace[334842592] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"134.853291ms","start":"2026-05-08T10:32:52.715232Z","end":"2026-05-08T10:32:52.850085Z","steps":["trace[334842592] 'process raft request'  (duration: 48.93313ms)","trace[334842592] 'compare'  (duration: 85.05366ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:32:53.317555Z","caller":"traceutil/trace.go:171","msg":"trace[1640196751] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"173.524413ms","start":"2026-05-08T10:32:53.143995Z","end":"2026-05-08T10:32:53.317519Z","steps":["trace[1640196751] 'process raft request'  (duration: 173.250947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.196764Z","caller":"traceutil/trace.go:171","msg":"trace[1454819995] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"146.722749ms","start":"2026-05-08T10:33:01.050008Z","end":"2026-05-08T10:33:01.196731Z","steps":["trace[1454819995] 'process raft request'  (duration: 99.692045ms)","trace[1454819995] 'compare'  (duration: 46.756907ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:33:01.429087Z","caller":"traceutil/trace.go:171","msg":"trace[696035369] linearizableReadLoop","detail":"{readStateIndex:5619; appliedIndex:5618; }","duration":"125.013505ms","start":"2026-05-08T10:33:01.304042Z","end":"2026-05-08T10:33:01.429055Z","steps":["trace[696035369] 'read index received'  (duration: 42.73981ms)","trace[696035369] 'applied index is now lower than readState.Index'  (duration: 82.272445ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:33:01.429229Z","caller":"traceutil/trace.go:171","msg":"trace[1497365130] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"211.969291ms","start":"2026-05-08T10:33:01.217248Z","end":"2026-05-08T10:33:01.429217Z","steps":["trace[1497365130] 'process raft request'  (duration: 129.626475ms)","trace[1497365130] 'compare'  (duration: 82.022158ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:33:01.429526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.465405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-05-08T10:33:01.429564Z","caller":"traceutil/trace.go:171","msg":"trace[1791811488] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5419; }","duration":"125.564348ms","start":"2026-05-08T10:33:01.303991Z","end":"2026-05-08T10:33:01.429555Z","steps":["trace[1791811488] 'agreement among raft nodes before linearized reading'  (duration: 125.404724ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.576493Z","caller":"traceutil/trace.go:171","msg":"trace[425054230] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"134.322618ms","start":"2026-05-08T10:33:01.442144Z","end":"2026-05-08T10:33:01.576466Z","steps":["trace[425054230] 'process raft request'  (duration: 126.585972ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.814839Z","caller":"traceutil/trace.go:171","msg":"trace[2106364328] transaction","detail":"{read_only:false; response_revision:5423; number_of_response:1; }","duration":"231.860269ms","start":"2026-05-08T10:33:01.582944Z","end":"2026-05-08T10:33:01.814804Z","steps":["trace[2106364328] 'process raft request'  (duration: 217.859542ms)","trace[2106364328] 'compare'  (duration: 13.772202ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:33:01.815068Z","caller":"traceutil/trace.go:171","msg":"trace[2029016628] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"231.720826ms","start":"2026-05-08T10:33:01.583313Z","end":"2026-05-08T10:33:01.815034Z","steps":["trace[2029016628] 'process raft request'  (duration: 231.423309ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.81522Z","caller":"traceutil/trace.go:171","msg":"trace[598591365] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"231.904611ms","start":"2026-05-08T10:33:01.583296Z","end":"2026-05-08T10:33:01.8152Z","steps":["trace[598591365] 'process raft request'  (duration: 231.517631ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.815502Z","caller":"traceutil/trace.go:171","msg":"trace[559310838] linearizableReadLoop","detail":"{readStateIndex:5629; appliedIndex:5622; }","duration":"160.692964ms","start":"2026-05-08T10:33:01.654796Z","end":"2026-05-08T10:33:01.815489Z","steps":["trace[559310838] 'read index received'  (duration: 146.157303ms)","trace[559310838] 'applied index is now lower than readState.Index'  (duration: 14.534361ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:33:01.815778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.460791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18ad9090f3b557ab\" ","response":"range_response_count:1 size:1012"}
{"level":"info","ts":"2026-05-08T10:33:01.815472Z","caller":"traceutil/trace.go:171","msg":"trace[964935193] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"232.066955ms","start":"2026-05-08T10:33:01.583339Z","end":"2026-05-08T10:33:01.815406Z","steps":["trace[964935193] 'process raft request'  (duration: 231.504581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.815862Z","caller":"traceutil/trace.go:171","msg":"trace[645015540] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18ad9090f3b557ab; range_end:; response_count:1; response_revision:5429; }","duration":"219.579925ms","start":"2026-05-08T10:33:01.596259Z","end":"2026-05-08T10:33:01.815839Z","steps":["trace[645015540] 'agreement among raft nodes before linearized reading'  (duration: 219.295748ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.815568Z","caller":"traceutil/trace.go:171","msg":"trace[1433340137] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"230.535948ms","start":"2026-05-08T10:33:01.585022Z","end":"2026-05-08T10:33:01.815558Z","steps":["trace[1433340137] 'process raft request'  (duration: 230.428436ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:33:01.815922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.643644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:1267"}
{"level":"info","ts":"2026-05-08T10:33:01.815988Z","caller":"traceutil/trace.go:171","msg":"trace[1979905910] range","detail":"{range_begin:/registry/ingress/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:5429; }","duration":"233.780357ms","start":"2026-05-08T10:33:01.582191Z","end":"2026-05-08T10:33:01.815971Z","steps":["trace[1979905910] 'agreement among raft nodes before linearized reading'  (duration: 233.529311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.815972Z","caller":"traceutil/trace.go:171","msg":"trace[833702432] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"155.224813ms","start":"2026-05-08T10:33:01.660733Z","end":"2026-05-08T10:33:01.815958Z","steps":["trace[833702432] 'process raft request'  (duration: 154.969857ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.815571Z","caller":"traceutil/trace.go:171","msg":"trace[1988798768] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"230.576799ms","start":"2026-05-08T10:33:01.58498Z","end":"2026-05-08T10:33:01.815557Z","steps":["trace[1988798768] 'process raft request'  (duration: 230.404655ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:01.815599Z","caller":"traceutil/trace.go:171","msg":"trace[84521280] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"230.785385ms","start":"2026-05-08T10:33:01.584808Z","end":"2026-05-08T10:33:01.815593Z","steps":["trace[84521280] 'process raft request'  (duration: 230.065867ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:12.781657Z","caller":"traceutil/trace.go:171","msg":"trace[787720748] transaction","detail":"{read_only:false; response_revision:5582; number_of_response:1; }","duration":"130.058781ms","start":"2026-05-08T10:33:12.651565Z","end":"2026-05-08T10:33:12.781624Z","steps":["trace[787720748] 'process raft request'  (duration: 129.842886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:33:13.223276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.241612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:33:13.223385Z","caller":"traceutil/trace.go:171","msg":"trace[1802876727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5584; }","duration":"115.400226ms","start":"2026-05-08T10:33:13.10796Z","end":"2026-05-08T10:33:13.22336Z","steps":["trace[1802876727] 'agreement among raft nodes before linearized reading'  (duration: 115.210622ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:33:13.223531Z","caller":"traceutil/trace.go:171","msg":"trace[379039091] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"129.257842ms","start":"2026-05-08T10:33:13.094231Z","end":"2026-05-08T10:33:13.223489Z","steps":["trace[379039091] 'process raft request'  (duration: 128.74591ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:34:07.486582Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975}
{"level":"info","ts":"2026-05-08T10:34:07.617563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"126.666858ms","hash":1181797886,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":33529856,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-08T10:34:07.617644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1181797886,"revision":2975,"compact-revision":-1}
{"level":"info","ts":"2026-05-08T10:39:03.291039Z","caller":"traceutil/trace.go:171","msg":"trace[1312471242] transaction","detail":"{read_only:false; response_revision:8227; number_of_response:1; }","duration":"164.514011ms","start":"2026-05-08T10:39:03.12649Z","end":"2026-05-08T10:39:03.291004Z","steps":["trace[1312471242] 'process raft request'  (duration: 164.293885ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:03.570113Z","caller":"traceutil/trace.go:171","msg":"trace[1977102389] linearizableReadLoop","detail":"{readStateIndex:8514; appliedIndex:8512; }","duration":"281.378489ms","start":"2026-05-08T10:39:03.288691Z","end":"2026-05-08T10:39:03.570069Z","steps":["trace[1977102389] 'read index received'  (duration: 2.112171ms)","trace[1977102389] 'applied index is now lower than readState.Index'  (duration: 279.264608ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:39:03.570242Z","caller":"traceutil/trace.go:171","msg":"trace[159504733] transaction","detail":"{read_only:false; response_revision:8228; number_of_response:1; }","duration":"420.27572ms","start":"2026-05-08T10:39:03.149904Z","end":"2026-05-08T10:39:03.57018Z","steps":["trace[159504733] 'process raft request'  (duration: 414.611743ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:39:03.5704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.699127ms","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-08T10:39:03.570441Z","caller":"traceutil/trace.go:171","msg":"trace[100286874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8228; }","duration":"281.86432ms","start":"2026-05-08T10:39:03.288568Z","end":"2026-05-08T10:39:03.570432Z","steps":["trace[100286874] 'agreement among raft nodes before linearized reading'  (duration: 281.667315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:39:03.571822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:39:03.149881Z","time spent":"420.442324ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8215 > 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-08T10:39:03.572956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.743442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-08T10:39:03.573056Z","caller":"traceutil/trace.go:171","msg":"trace[1249339845] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8229; }","duration":"282.911236ms","start":"2026-05-08T10:39:03.290124Z","end":"2026-05-08T10:39:03.573035Z","steps":["trace[1249339845] 'agreement among raft nodes before linearized reading'  (duration: 282.681251ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:03.573195Z","caller":"traceutil/trace.go:171","msg":"trace[2143039573] transaction","detail":"{read_only:false; response_revision:8229; number_of_response:1; }","duration":"189.822143ms","start":"2026-05-08T10:39:03.383352Z","end":"2026-05-08T10:39:03.573174Z","steps":["trace[2143039573] 'process raft request'  (duration: 189.340412ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:39:03.573308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.118075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vzgt5\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-05-08T10:39:03.573373Z","caller":"traceutil/trace.go:171","msg":"trace[691636578] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vzgt5; range_end:; response_count:1; response_revision:8229; }","duration":"179.254718ms","start":"2026-05-08T10:39:03.394102Z","end":"2026-05-08T10:39:03.573357Z","steps":["trace[691636578] 'agreement among raft nodes before linearized reading'  (duration: 179.061963ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:39:03.574019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.688049ms","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-08T10:39:03.574128Z","caller":"traceutil/trace.go:171","msg":"trace[901551245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8229; }","duration":"117.852483ms","start":"2026-05-08T10:39:03.456237Z","end":"2026-05-08T10:39:03.574089Z","steps":["trace[901551245] 'agreement among raft nodes before linearized reading'  (duration: 116.898619ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:07.517651Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6028}
{"level":"info","ts":"2026-05-08T10:39:07.744026Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6028,"took":"223.643502ms","hash":2842491353,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":23609344,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-08T10:39:07.744104Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2842491353,"revision":6028,"compact-revision":2975}
{"level":"info","ts":"2026-05-08T10:39:16.039593Z","caller":"traceutil/trace.go:171","msg":"trace[967763015] transaction","detail":"{read_only:false; response_revision:8292; number_of_response:1; }","duration":"236.597335ms","start":"2026-05-08T10:39:15.802961Z","end":"2026-05-08T10:39:16.039558Z","steps":["trace[967763015] 'process raft request'  (duration: 236.406311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:16.088505Z","caller":"traceutil/trace.go:171","msg":"trace[944700412] transaction","detail":"{read_only:false; response_revision:8295; number_of_response:1; }","duration":"285.190532ms","start":"2026-05-08T10:39:15.803292Z","end":"2026-05-08T10:39:16.088483Z","steps":["trace[944700412] 'process raft request'  (duration: 285.1132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:16.088542Z","caller":"traceutil/trace.go:171","msg":"trace[1898198847] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"285.344595ms","start":"2026-05-08T10:39:15.803146Z","end":"2026-05-08T10:39:16.088491Z","steps":["trace[1898198847] 'process raft request'  (duration: 285.072989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:16.088684Z","caller":"traceutil/trace.go:171","msg":"trace[2111979677] transaction","detail":"{read_only:false; response_revision:8294; number_of_response:1; }","duration":"285.391757ms","start":"2026-05-08T10:39:15.803277Z","end":"2026-05-08T10:39:16.088668Z","steps":["trace[2111979677] 'process raft request'  (duration: 285.079209ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:16.088935Z","caller":"traceutil/trace.go:171","msg":"trace[825306176] transaction","detail":"{read_only:false; response_revision:8296; number_of_response:1; }","duration":"184.645779ms","start":"2026-05-08T10:39:15.904238Z","end":"2026-05-08T10:39:16.088884Z","steps":["trace[825306176] 'process raft request'  (duration: 184.209768ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:44.072293Z","caller":"traceutil/trace.go:171","msg":"trace[72855213] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"257.906171ms","start":"2026-05-08T10:39:43.814361Z","end":"2026-05-08T10:39:44.072267Z","steps":["trace[72855213] 'process raft request'  (duration: 257.761427ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:44.281134Z","caller":"traceutil/trace.go:171","msg":"trace[162314121] linearizableReadLoop","detail":"{readStateIndex:8794; appliedIndex:8793; }","duration":"297.211772ms","start":"2026-05-08T10:39:43.983894Z","end":"2026-05-08T10:39:44.281105Z","steps":["trace[162314121] 'read index received'  (duration: 88.984892ms)","trace[162314121] 'applied index is now lower than readState.Index'  (duration: 208.22557ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:39:44.281559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.648433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vzgt5\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-05-08T10:39:44.281633Z","caller":"traceutil/trace.go:171","msg":"trace[246623399] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vzgt5; range_end:; response_count:1; response_revision:8497; }","duration":"297.759395ms","start":"2026-05-08T10:39:43.983857Z","end":"2026-05-08T10:39:44.281617Z","steps":["trace[246623399] 'agreement among raft nodes before linearized reading'  (duration: 297.626552ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:39:44.282254Z","caller":"traceutil/trace.go:171","msg":"trace[1817101033] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"458.788263ms","start":"2026-05-08T10:39:43.822462Z","end":"2026-05-08T10:39:44.28125Z","steps":["trace[1817101033] 'process raft request'  (duration: 453.053934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:39:44.282525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:39:43.822449Z","time spent":"459.90366ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8485 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T10:40:41.982356Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002470.wal"}
{"level":"info","ts":"2026-05-08T10:40:56.747877Z","caller":"traceutil/trace.go:171","msg":"trace[503885460] transaction","detail":"{read_only:false; response_revision:9224; number_of_response:1; }","duration":"149.54803ms","start":"2026-05-08T10:40:56.598284Z","end":"2026-05-08T10:40:56.747832Z","steps":["trace[503885460] 'process raft request'  (duration: 135.246914ms)","trace[503885460] 'compare'  (duration: 14.026469ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:40:56.747939Z","caller":"traceutil/trace.go:171","msg":"trace[562503336] linearizableReadLoop","detail":"{readStateIndex:9544; appliedIndex:9542; }","duration":"132.981189ms","start":"2026-05-08T10:40:56.614934Z","end":"2026-05-08T10:40:56.747915Z","steps":["trace[562503336] 'read index received'  (duration: 118.615432ms)","trace[562503336] 'applied index is now lower than readState.Index'  (duration: 14.360057ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:40:56.748102Z","caller":"traceutil/trace.go:171","msg":"trace[1940273359] transaction","detail":"{read_only:false; response_revision:9225; number_of_response:1; }","duration":"146.247119ms","start":"2026-05-08T10:40:56.601845Z","end":"2026-05-08T10:40:56.748092Z","steps":["trace[1940273359] 'process raft request'  (duration: 145.907451ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:40:56.748339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.005194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/rook-ceph-crashcollector-instance\" ","response":"range_response_count:1 size:8948"}
{"level":"info","ts":"2026-05-08T10:40:56.748384Z","caller":"traceutil/trace.go:171","msg":"trace[1732889207] range","detail":"{range_begin:/registry/deployments/openstack/rook-ceph-crashcollector-instance; range_end:; response_count:1; response_revision:9225; }","duration":"153.071305ms","start":"2026-05-08T10:40:56.595297Z","end":"2026-05-08T10:40:56.748369Z","steps":["trace[1732889207] 'agreement among raft nodes before linearized reading'  (duration: 152.897731ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:40:56.750885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.748405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-crashcollector-instance-754c646bfd-7bfv5\" ","response":"range_response_count:1 size:8305"}
{"level":"info","ts":"2026-05-08T10:40:56.750962Z","caller":"traceutil/trace.go:171","msg":"trace[515925269] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-crashcollector-instance-754c646bfd-7bfv5; range_end:; response_count:1; response_revision:9226; }","duration":"123.885198ms","start":"2026-05-08T10:40:56.627058Z","end":"2026-05-08T10:40:56.750943Z","steps":["trace[515925269] 'agreement among raft nodes before linearized reading'  (duration: 123.638962ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:40:56.751289Z","caller":"traceutil/trace.go:171","msg":"trace[548039057] transaction","detail":"{read_only:false; response_revision:9226; number_of_response:1; }","duration":"131.452542ms","start":"2026-05-08T10:40:56.619814Z","end":"2026-05-08T10:40:56.751267Z","steps":["trace[548039057] 'process raft request'  (duration: 130.53838ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:40:56.751862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.952276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/rook-ceph-crashcollector-instance\" ","response":"range_response_count:1 size:8948"}
{"level":"info","ts":"2026-05-08T10:40:56.751889Z","caller":"traceutil/trace.go:171","msg":"trace[1761978468] range","detail":"{range_begin:/registry/deployments/openstack/rook-ceph-crashcollector-instance; range_end:; response_count:1; response_revision:9226; }","duration":"123.001267ms","start":"2026-05-08T10:40:56.628878Z","end":"2026-05-08T10:40:56.751879Z","steps":["trace[1761978468] 'agreement among raft nodes before linearized reading'  (duration: 122.931285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:40:58.993418Z","caller":"traceutil/trace.go:171","msg":"trace[197462549] linearizableReadLoop","detail":"{readStateIndex:9591; appliedIndex:9589; }","duration":"167.111393ms","start":"2026-05-08T10:40:58.82626Z","end":"2026-05-08T10:40:58.993372Z","steps":["trace[197462549] 'read index received'  (duration: 55.844732ms)","trace[197462549] 'applied index is now lower than readState.Index'  (duration: 111.265311ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:40:58.993512Z","caller":"traceutil/trace.go:171","msg":"trace[1268453453] transaction","detail":"{read_only:false; response_revision:9271; number_of_response:1; }","duration":"173.942889ms","start":"2026-05-08T10:40:58.819514Z","end":"2026-05-08T10:40:58.993457Z","steps":["trace[1268453453] 'process raft request'  (duration: 136.233557ms)","trace[1268453453] 'compare'  (duration: 37.433266ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:40:58.993656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.494265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:40:58.993697Z","caller":"traceutil/trace.go:171","msg":"trace[1312917935] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9271; }","duration":"127.606158ms","start":"2026-05-08T10:40:58.866078Z","end":"2026-05-08T10:40:58.993684Z","steps":["trace[1312917935] 'agreement among raft nodes before linearized reading'  (duration: 127.502595ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:40:58.993808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.562416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-6d8d788dcb-nblp5.18ad90fcc70de61b\" ","response":"range_response_count:1 size:787"}
{"level":"warn","ts":"2026-05-08T10:40:58.993861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.555695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-08T10:40:58.99392Z","caller":"traceutil/trace.go:171","msg":"trace[1265796520] range","detail":"{range_begin:/registry/events/openstack/glance-api-6d8d788dcb-nblp5.18ad90fcc70de61b; range_end:; response_count:1; response_revision:9271; }","duration":"122.717969ms","start":"2026-05-08T10:40:58.87116Z","end":"2026-05-08T10:40:58.993878Z","steps":["trace[1265796520] 'agreement among raft nodes before linearized reading'  (duration: 122.461103ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:40:58.993982Z","caller":"traceutil/trace.go:171","msg":"trace[1399631914] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:9271; }","duration":"167.699058ms","start":"2026-05-08T10:40:58.826254Z","end":"2026-05-08T10:40:58.993953Z","steps":["trace[1399631914] 'agreement among raft nodes before linearized reading'  (duration: 167.254458ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:41:55.071733Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d1606b245347dc08","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T10:41:55.085123Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-08T10:41:55.086885Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-08T10:44:07.527656Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8247}
{"level":"info","ts":"2026-05-08T10:44:07.6192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8247,"took":"88.638622ms","hash":4174117384,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":26095616,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-08T10:44:07.619292Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4174117384,"revision":8247,"compact-revision":6028}
{"level":"info","ts":"2026-05-08T10:44:52.434334Z","caller":"traceutil/trace.go:171","msg":"trace[1446531186] transaction","detail":"{read_only:false; response_revision:11189; number_of_response:1; }","duration":"104.118345ms","start":"2026-05-08T10:44:52.33018Z","end":"2026-05-08T10:44:52.434299Z","steps":["trace[1446531186] 'process raft request'  (duration: 103.616503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:49:07.537446Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10740}
{"level":"info","ts":"2026-05-08T10:49:07.620488Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10740,"took":"79.898621ms","hash":2164053663,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":27865088,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-08T10:49:07.620575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2164053663,"revision":10740,"compact-revision":8247}
{"level":"info","ts":"2026-05-08T10:50:41.140829Z","caller":"traceutil/trace.go:171","msg":"trace[813894209] transaction","detail":"{read_only:false; response_revision:13568; number_of_response:1; }","duration":"140.6051ms","start":"2026-05-08T10:50:41.000195Z","end":"2026-05-08T10:50:41.1408Z","steps":["trace[813894209] 'process raft request'  (duration: 140.430355ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:50:41.14296Z","caller":"traceutil/trace.go:171","msg":"trace[1722123666] transaction","detail":"{read_only:false; response_revision:13569; number_of_response:1; }","duration":"141.44369ms","start":"2026-05-08T10:50:41.001463Z","end":"2026-05-08T10:50:41.142907Z","steps":["trace[1722123666] 'process raft request'  (duration: 141.145583ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:51:04.489148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.446713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-08T10:51:04.489244Z","caller":"traceutil/trace.go:171","msg":"trace[1001947788] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13697; }","duration":"124.616957ms","start":"2026-05-08T10:51:04.364604Z","end":"2026-05-08T10:51:04.489221Z","steps":["trace[1001947788] 'range keys from in-memory index tree'  (duration: 124.184156ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:51:21.208279Z","caller":"traceutil/trace.go:171","msg":"trace[1714947081] transaction","detail":"{read_only:false; response_revision:13795; number_of_response:1; }","duration":"390.112187ms","start":"2026-05-08T10:51:20.818122Z","end":"2026-05-08T10:51:21.208234Z","steps":["trace[1714947081] 'process raft request'  (duration: 297.742206ms)","trace[1714947081] 'compare'  (duration: 92.045363ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:51:21.208526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:51:20.818096Z","time spent":"390.308952ms","remote":"127.0.0.1:51622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.35\" mod_revision:13727 > success:<request_put:<key:\"/registry/masterleases/199.19.213.35\" value_size:67 lease:6631724204703234292 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.35\" > >"}
{"level":"info","ts":"2026-05-08T10:51:21.208902Z","caller":"traceutil/trace.go:171","msg":"trace[462407343] transaction","detail":"{read_only:false; response_revision:13796; number_of_response:1; }","duration":"386.980482ms","start":"2026-05-08T10:51:20.821859Z","end":"2026-05-08T10:51:21.208839Z","steps":["trace[462407343] 'process raft request'  (duration: 386.437439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:51:21.208897Z","caller":"traceutil/trace.go:171","msg":"trace[391544902] transaction","detail":"{read_only:false; response_revision:13797; number_of_response:1; }","duration":"289.094899ms","start":"2026-05-08T10:51:20.919751Z","end":"2026-05-08T10:51:21.208846Z","steps":["trace[391544902] 'process raft request'  (duration: 288.671079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:51:21.209133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:51:20.821841Z","time spent":"387.171306ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:13769 > 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-08T10:51:21.209121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.372577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:51:21.209213Z","caller":"traceutil/trace.go:171","msg":"trace[1774052985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13797; }","duration":"101.51973ms","start":"2026-05-08T10:51:21.10767Z","end":"2026-05-08T10:51:21.20919Z","steps":["trace[1774052985] 'agreement among raft nodes before linearized reading'  (duration: 101.310955ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:51:21.208492Z","caller":"traceutil/trace.go:171","msg":"trace[641880088] linearizableReadLoop","detail":"{readStateIndex:14266; appliedIndex:14263; }","duration":"100.750892ms","start":"2026-05-08T10:51:21.107713Z","end":"2026-05-08T10:51:21.208464Z","steps":["trace[641880088] 'read index received'  (duration: 8.219208ms)","trace[641880088] 'applied index is now lower than readState.Index'  (duration: 92.530384ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:51:22.72937Z","caller":"traceutil/trace.go:171","msg":"trace[965253222] transaction","detail":"{read_only:false; response_revision:13813; number_of_response:1; }","duration":"101.058459ms","start":"2026-05-08T10:51:22.628256Z","end":"2026-05-08T10:51:22.729314Z","steps":["trace[965253222] 'compare'  (duration: 90.841785ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:51:44.110997Z","caller":"traceutil/trace.go:171","msg":"trace[69071336] transaction","detail":"{read_only:false; response_revision:14110; number_of_response:1; }","duration":"349.606022ms","start":"2026-05-08T10:51:43.761348Z","end":"2026-05-08T10:51:44.110954Z","steps":["trace[69071336] 'process raft request'  (duration: 349.07823ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:51:44.111485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:51:43.761276Z","time spent":"349.838748ms","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3738,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-738de62d-7a3e-459a-8c1c-0ce51c90c8f2\" mod_revision:14087 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-738de62d-7a3e-459a-8c1c-0ce51c90c8f2\" value_size:3638 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-738de62d-7a3e-459a-8c1c-0ce51c90c8f2\" > >"}
{"level":"info","ts":"2026-05-08T10:53:09.777969Z","caller":"traceutil/trace.go:171","msg":"trace[840259888] transaction","detail":"{read_only:false; response_revision:14923; number_of_response:1; }","duration":"107.165236ms","start":"2026-05-08T10:53:09.670736Z","end":"2026-05-08T10:53:09.777901Z","steps":["trace[840259888] 'process raft request'  (duration: 106.857979ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.103869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.767846ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558013818 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:14917 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T10:53:10.104011Z","caller":"traceutil/trace.go:171","msg":"trace[738361460] linearizableReadLoop","detail":"{readStateIndex:15430; appliedIndex:15429; }","duration":"227.899847ms","start":"2026-05-08T10:53:09.87609Z","end":"2026-05-08T10:53:10.10399Z","steps":["trace[738361460] 'read index received'  (duration: 68.69326ms)","trace[738361460] 'applied index is now lower than readState.Index'  (duration: 159.204647ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:53:10.104051Z","caller":"traceutil/trace.go:171","msg":"trace[785862535] transaction","detail":"{read_only:false; response_revision:14926; number_of_response:1; }","duration":"312.86298ms","start":"2026-05-08T10:53:09.791141Z","end":"2026-05-08T10:53:10.104004Z","steps":["trace[785862535] 'process raft request'  (duration: 153.666753ms)","trace[785862535] 'compare'  (duration: 158.50676ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:53:10.10416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.568079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:53:10.104197Z","caller":"traceutil/trace.go:171","msg":"trace[19251192] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14926; }","duration":"227.626011ms","start":"2026-05-08T10:53:09.876559Z","end":"2026-05-08T10:53:10.104185Z","steps":["trace[19251192] 'agreement among raft nodes before linearized reading'  (duration: 227.550039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.104192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.048187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-08T10:53:10.104254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:53:09.791107Z","time spent":"313.037854ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:14917 > 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-08T10:53:10.104285Z","caller":"traceutil/trace.go:171","msg":"trace[540262381] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14926; }","duration":"123.181461ms","start":"2026-05-08T10:53:09.981084Z","end":"2026-05-08T10:53:10.104265Z","steps":["trace[540262381] 'agreement among raft nodes before linearized reading'  (duration: 123.030137ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.104324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.210854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"warn","ts":"2026-05-08T10:53:10.104438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.618698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:53:10.104433Z","caller":"traceutil/trace.go:171","msg":"trace[1853645154] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14926; }","duration":"228.375258ms","start":"2026-05-08T10:53:09.87603Z","end":"2026-05-08T10:53:10.104405Z","steps":["trace[1853645154] 'agreement among raft nodes before linearized reading'  (duration: 228.04084ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:53:10.104473Z","caller":"traceutil/trace.go:171","msg":"trace[491409325] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14926; }","duration":"122.670589ms","start":"2026-05-08T10:53:09.981794Z","end":"2026-05-08T10:53:10.104464Z","steps":["trace[491409325] 'agreement among raft nodes before linearized reading'  (duration: 122.620838ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.104587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.704073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-08T10:53:10.104646Z","caller":"traceutil/trace.go:171","msg":"trace[1574646655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14926; }","duration":"133.788455ms","start":"2026-05-08T10:53:09.970849Z","end":"2026-05-08T10:53:10.104637Z","steps":["trace[1574646655] 'agreement among raft nodes before linearized reading'  (duration: 133.616351ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.104649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.494308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:53:10.104692Z","caller":"traceutil/trace.go:171","msg":"trace[1808034628] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14926; }","duration":"123.55095ms","start":"2026-05-08T10:53:09.981129Z","end":"2026-05-08T10:53:10.104679Z","steps":["trace[1808034628] 'agreement among raft nodes before linearized reading'  (duration: 123.463608ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.10485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.396195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-05-08T10:53:10.104889Z","caller":"traceutil/trace.go:171","msg":"trace[721048826] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14926; }","duration":"160.447087ms","start":"2026-05-08T10:53:09.944433Z","end":"2026-05-08T10:53:10.10488Z","steps":["trace[721048826] 'agreement among raft nodes before linearized reading'  (duration: 160.342954ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.104895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.535769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-05-08T10:53:10.104872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.509251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-05-08T10:53:10.104971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.680472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T10:53:10.104983Z","caller":"traceutil/trace.go:171","msg":"trace[2084955726] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14926; }","duration":"121.647283ms","start":"2026-05-08T10:53:09.983309Z","end":"2026-05-08T10:53:10.104957Z","steps":["trace[2084955726] 'agreement among raft nodes before linearized reading'  (duration: 121.07464ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:53:10.10501Z","caller":"traceutil/trace.go:171","msg":"trace[446915163] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14926; }","duration":"160.727913ms","start":"2026-05-08T10:53:09.944275Z","end":"2026-05-08T10:53:10.105003Z","steps":["trace[446915163] 'agreement among raft nodes before linearized reading'  (duration: 160.676302ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:53:10.10493Z","caller":"traceutil/trace.go:171","msg":"trace[1200762494] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14926; }","duration":"227.595321ms","start":"2026-05-08T10:53:09.877325Z","end":"2026-05-08T10:53:10.10492Z","steps":["trace[1200762494] 'agreement among raft nodes before linearized reading'  (duration: 227.455047ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.105341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.073082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-05-08T10:53:10.105384Z","caller":"traceutil/trace.go:171","msg":"trace[1924873267] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14926; }","duration":"161.153684ms","start":"2026-05-08T10:53:09.94422Z","end":"2026-05-08T10:53:10.105374Z","steps":["trace[1924873267] 'agreement among raft nodes before linearized reading'  (duration: 160.886437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:53:10.268378Z","caller":"traceutil/trace.go:171","msg":"trace[1690342623] linearizableReadLoop","detail":"{readStateIndex:15431; appliedIndex:15430; }","duration":"125.780003ms","start":"2026-05-08T10:53:10.142571Z","end":"2026-05-08T10:53:10.268351Z","steps":["trace[1690342623] 'read index received'  (duration: 125.425195ms)","trace[1690342623] 'applied index is now lower than readState.Index'  (duration: 353.488µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:53:10.268668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.06586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-05-08T10:53:10.268712Z","caller":"traceutil/trace.go:171","msg":"trace[731826637] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14927; }","duration":"126.152372ms","start":"2026-05-08T10:53:10.142549Z","end":"2026-05-08T10:53:10.268701Z","steps":["trace[731826637] 'agreement among raft nodes before linearized reading'  (duration: 125.915337ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:53:10.268971Z","caller":"traceutil/trace.go:171","msg":"trace[699850295] transaction","detail":"{read_only:false; response_revision:14927; number_of_response:1; }","duration":"155.559909ms","start":"2026-05-08T10:53:10.113394Z","end":"2026-05-08T10:53:10.268954Z","steps":["trace[699850295] 'process raft request'  (duration: 154.685179ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:53:10.50078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.176078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18783"}
{"level":"info","ts":"2026-05-08T10:53:10.500898Z","caller":"traceutil/trace.go:171","msg":"trace[1477317589] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:14927; }","duration":"137.358272ms","start":"2026-05-08T10:53:10.363511Z","end":"2026-05-08T10:53:10.50087Z","steps":["trace[1477317589] 'range keys from in-memory index tree'  (duration: 136.975902ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:54:07.543538Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12905}
{"level":"info","ts":"2026-05-08T10:54:07.627934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12905,"took":"81.16121ms","hash":2420401641,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":30363648,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T10:54:07.628015Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2420401641,"revision":12905,"compact-revision":10740}
{"level":"info","ts":"2026-05-08T10:58:52.289083Z","caller":"traceutil/trace.go:171","msg":"trace[1175079194] linearizableReadLoop","detail":"{readStateIndex:18066; appliedIndex:18065; }","duration":"261.750459ms","start":"2026-05-08T10:58:52.027295Z","end":"2026-05-08T10:58:52.289045Z","steps":["trace[1175079194] 'read index received'  (duration: 261.446282ms)","trace[1175079194] 'applied index is now lower than readState.Index'  (duration: 303.107µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:58:52.28923Z","caller":"traceutil/trace.go:171","msg":"trace[242261844] transaction","detail":"{read_only:false; response_revision:17477; number_of_response:1; }","duration":"271.901573ms","start":"2026-05-08T10:58:52.017271Z","end":"2026-05-08T10:58:52.289173Z","steps":["trace[242261844] 'process raft request'  (duration: 271.489674ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:58:52.289522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.204561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-08T10:58:52.289751Z","caller":"traceutil/trace.go:171","msg":"trace[1677236146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17477; }","duration":"262.325814ms","start":"2026-05-08T10:58:52.027235Z","end":"2026-05-08T10:58:52.289561Z","steps":["trace[1677236146] 'agreement among raft nodes before linearized reading'  (duration: 261.985616ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:58:52.32488Z","caller":"traceutil/trace.go:171","msg":"trace[1144686272] transaction","detail":"{read_only:false; response_revision:17478; number_of_response:1; }","duration":"259.076336ms","start":"2026-05-08T10:58:52.065775Z","end":"2026-05-08T10:58:52.324852Z","steps":["trace[1144686272] 'process raft request'  (duration: 258.790949ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:58:52.324996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.090223ms","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-08T10:58:52.325194Z","caller":"traceutil/trace.go:171","msg":"trace[1834400988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17478; }","duration":"246.316109ms","start":"2026-05-08T10:58:52.078824Z","end":"2026-05-08T10:58:52.32514Z","steps":["trace[1834400988] 'agreement among raft nodes before linearized reading'  (duration: 245.94677ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:58:52.325272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.337593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T10:58:52.325393Z","caller":"traceutil/trace.go:171","msg":"trace[427177886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17478; }","duration":"217.572928ms","start":"2026-05-08T10:58:52.107793Z","end":"2026-05-08T10:58:52.325366Z","steps":["trace[427177886] 'agreement among raft nodes before linearized reading'  (duration: 217.274801ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:58:52.325407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.251718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9kt56\" ","response":"range_response_count:1 size:9799"}
{"level":"info","ts":"2026-05-08T10:58:52.32546Z","caller":"traceutil/trace.go:171","msg":"trace[1546972418] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9kt56; range_end:; response_count:1; response_revision:17478; }","duration":"199.35386ms","start":"2026-05-08T10:58:52.126089Z","end":"2026-05-08T10:58:52.325443Z","steps":["trace[1546972418] 'agreement among raft nodes before linearized reading'  (duration: 198.773676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T10:58:52.554818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.627212ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558024004 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:17464 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T10:58:52.554966Z","caller":"traceutil/trace.go:171","msg":"trace[2015783939] linearizableReadLoop","detail":"{readStateIndex:18069; appliedIndex:18068; }","duration":"222.967949ms","start":"2026-05-08T10:58:52.331976Z","end":"2026-05-08T10:58:52.554944Z","steps":["trace[2015783939] 'read index received'  (duration: 111.097891ms)","trace[2015783939] 'applied index is now lower than readState.Index'  (duration: 111.867698ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T10:58:52.555191Z","caller":"traceutil/trace.go:171","msg":"trace[1433939115] transaction","detail":"{read_only:false; response_revision:17480; number_of_response:1; }","duration":"223.979683ms","start":"2026-05-08T10:58:52.331168Z","end":"2026-05-08T10:58:52.555147Z","steps":["trace[1433939115] 'process raft request'  (duration: 111.881319ms)","trace[1433939115] 'compare'  (duration: 111.425368ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T10:58:52.556181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.192208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:945997"}
{"level":"info","ts":"2026-05-08T10:58:52.556243Z","caller":"traceutil/trace.go:171","msg":"trace[219569242] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:17480; }","duration":"224.29587ms","start":"2026-05-08T10:58:52.331934Z","end":"2026-05-08T10:58:52.55623Z","steps":["trace[219569242] 'agreement among raft nodes before linearized reading'  (duration: 223.066331ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T10:59:07.551873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15286}
{"level":"info","ts":"2026-05-08T10:59:07.647778Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15286,"took":"91.55314ms","hash":401380280,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":32403456,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-08T10:59:07.647852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":401380280,"revision":15286,"compact-revision":12905}
{"level":"info","ts":"2026-05-08T11:02:30.037053Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d1606b245347dc08","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T11:02:30.042836Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-08T11:02:30.042975Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-08T11:04:07.560137Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17720}
{"level":"info","ts":"2026-05-08T11:04:07.662616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17720,"took":"98.067504ms","hash":3105372033,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":34013184,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-08T11:04:07.662698Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3105372033,"revision":17720,"compact-revision":15286}
{"level":"info","ts":"2026-05-08T11:05:52.204513Z","caller":"traceutil/trace.go:171","msg":"trace[1377224355] transaction","detail":"{read_only:false; response_revision:20666; number_of_response:1; }","duration":"155.176694ms","start":"2026-05-08T11:05:52.049283Z","end":"2026-05-08T11:05:52.204459Z","steps":["trace[1377224355] 'process raft request'  (duration: 154.800445ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:05:52.977791Z","caller":"traceutil/trace.go:171","msg":"trace[1204705512] transaction","detail":"{read_only:false; response_revision:20668; number_of_response:1; }","duration":"169.219721ms","start":"2026-05-08T11:05:52.808535Z","end":"2026-05-08T11:05:52.977755Z","steps":["trace[1204705512] 'process raft request'  (duration: 138.301849ms)","trace[1204705512] 'compare'  (duration: 30.40071ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:09:07.566798Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20066}
{"level":"info","ts":"2026-05-08T11:09:07.679288Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20066,"took":"107.660255ms","hash":1216601669,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":29786112,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T11:09:07.679377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1216601669,"revision":20066,"compact-revision":17720}
{"level":"info","ts":"2026-05-08T11:09:40.978182Z","caller":"traceutil/trace.go:171","msg":"trace[622747410] transaction","detail":"{read_only:false; response_revision:23026; number_of_response:1; }","duration":"118.604682ms","start":"2026-05-08T11:09:40.859523Z","end":"2026-05-08T11:09:40.978128Z","steps":["trace[622747410] 'process raft request'  (duration: 115.185942ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:09:41.262944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.923996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:09:41.263075Z","caller":"traceutil/trace.go:171","msg":"trace[551269033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23027; }","duration":"157.126642ms","start":"2026-05-08T11:09:41.105917Z","end":"2026-05-08T11:09:41.263044Z","steps":["trace[551269033] 'range keys from in-memory index tree'  (duration: 156.836025ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:09:41.38581Z","caller":"traceutil/trace.go:171","msg":"trace[924668038] transaction","detail":"{read_only:false; response_revision:23029; number_of_response:1; }","duration":"119.610733ms","start":"2026-05-08T11:09:41.266165Z","end":"2026-05-08T11:09:41.385776Z","steps":["trace[924668038] 'process raft request'  (duration: 117.693579ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:10:30.253444Z","caller":"traceutil/trace.go:171","msg":"trace[94124760] transaction","detail":"{read_only:false; response_revision:23590; number_of_response:1; }","duration":"106.640663ms","start":"2026-05-08T11:10:30.146771Z","end":"2026-05-08T11:10:30.253411Z","steps":["trace[94124760] 'process raft request'  (duration: 84.539896ms)","trace[94124760] 'compare'  (duration: 21.709867ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:11:00.475477Z","caller":"traceutil/trace.go:171","msg":"trace[1377394789] transaction","detail":"{read_only:false; response_revision:23940; number_of_response:1; }","duration":"149.119614ms","start":"2026-05-08T11:11:00.32633Z","end":"2026-05-08T11:11:00.47545Z","steps":["trace[1377394789] 'process raft request'  (duration: 148.93266ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:11:00.490698Z","caller":"traceutil/trace.go:171","msg":"trace[1884245709] transaction","detail":"{read_only:false; response_revision:23942; number_of_response:1; }","duration":"131.997544ms","start":"2026-05-08T11:11:00.358668Z","end":"2026-05-08T11:11:00.490666Z","steps":["trace[1884245709] 'process raft request'  (duration: 131.890172ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:11:00.490697Z","caller":"traceutil/trace.go:171","msg":"trace[1482416319] transaction","detail":"{read_only:false; response_revision:23941; number_of_response:1; }","duration":"153.684521ms","start":"2026-05-08T11:11:00.336966Z","end":"2026-05-08T11:11:00.490651Z","steps":["trace[1482416319] 'process raft request'  (duration: 153.283582ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:11:00.491094Z","caller":"traceutil/trace.go:171","msg":"trace[615093976] transaction","detail":"{read_only:false; response_revision:23944; number_of_response:1; }","duration":"100.59169ms","start":"2026-05-08T11:11:00.390465Z","end":"2026-05-08T11:11:00.491056Z","steps":["trace[615093976] 'process raft request'  (duration: 100.379645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:11:00.491227Z","caller":"traceutil/trace.go:171","msg":"trace[633670544] transaction","detail":"{read_only:false; response_revision:23943; number_of_response:1; }","duration":"108.76156ms","start":"2026-05-08T11:11:00.382327Z","end":"2026-05-08T11:11:00.491089Z","steps":["trace[633670544] 'process raft request'  (duration: 108.295309ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:57.312884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.665605ms","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-08T11:12:57.313022Z","caller":"traceutil/trace.go:171","msg":"trace[662145595] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25062; }","duration":"142.862529ms","start":"2026-05-08T11:12:57.170129Z","end":"2026-05-08T11:12:57.312991Z","steps":["trace[662145595] 'range keys from in-memory index tree'  (duration: 142.560012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:57.561257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.13522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T11:12:57.56141Z","caller":"traceutil/trace.go:171","msg":"trace[1352681838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25063; }","duration":"101.346265ms","start":"2026-05-08T11:12:57.460036Z","end":"2026-05-08T11:12:57.561382Z","steps":["trace[1352681838] 'range keys from in-memory index tree'  (duration: 100.210177ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:57.930737Z","caller":"traceutil/trace.go:171","msg":"trace[1854357561] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"365.02657ms","start":"2026-05-08T11:12:57.565668Z","end":"2026-05-08T11:12:57.930694Z","steps":["trace[1854357561] 'process raft request'  (duration: 329.403935ms)","trace[1854357561] 'compare'  (duration: 35.475471ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:12:57.930925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.565636Z","time spent":"365.196054ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25050 > 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-08T11:12:58.217637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.643465ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045119 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25049 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:12:58.217939Z","caller":"traceutil/trace.go:171","msg":"trace[754915426] transaction","detail":"{read_only:false; response_revision:25066; number_of_response:1; }","duration":"651.176908ms","start":"2026-05-08T11:12:57.56672Z","end":"2026-05-08T11:12:58.217897Z","steps":["trace[754915426] 'process raft request'  (duration: 481.118823ms)","trace[754915426] 'compare'  (duration: 169.187705ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:12:58.217995Z","caller":"traceutil/trace.go:171","msg":"trace[382475471] linearizableReadLoop","detail":"{readStateIndex:25886; appliedIndex:25884; }","duration":"648.141516ms","start":"2026-05-08T11:12:57.569823Z","end":"2026-05-08T11:12:58.217965Z","steps":["trace[382475471] 'read index received'  (duration: 325.267276ms)","trace[382475471] 'applied index is now lower than readState.Index'  (duration: 322.8728ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:12:58.218676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.839103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"}
{"level":"info","ts":"2026-05-08T11:12:58.218757Z","caller":"traceutil/trace.go:171","msg":"trace[612852297] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25068; }","duration":"648.954395ms","start":"2026-05-08T11:12:57.569783Z","end":"2026-05-08T11:12:58.218738Z","steps":["trace[612852297] 'agreement among raft nodes before linearized reading'  (duration: 648.608507ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.218123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.566694Z","time spent":"651.339031ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25049 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T11:12:58.218814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.569772Z","time spent":"649.027467ms","remote":"127.0.0.1:52020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11861,"request content":"key:\"/registry/deployments/openstack/glance-api\" "}
{"level":"info","ts":"2026-05-08T11:12:58.218182Z","caller":"traceutil/trace.go:171","msg":"trace[1995092115] transaction","detail":"{read_only:false; response_revision:25067; number_of_response:1; }","duration":"622.261822ms","start":"2026-05-08T11:12:57.59591Z","end":"2026-05-08T11:12:58.218171Z","steps":["trace[1995092115] 'process raft request'  (duration: 621.874483ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.219115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.087839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-05-08T11:12:58.219221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.106079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:12:58.219296Z","caller":"traceutil/trace.go:171","msg":"trace[1427622160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25068; }","duration":"112.250633ms","start":"2026-05-08T11:12:58.107028Z","end":"2026-05-08T11:12:58.219278Z","steps":["trace[1427622160] 'agreement among raft nodes before linearized reading'  (duration: 112.113579ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.219338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.414738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-08T11:12:58.219295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.192555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:12:58.219384Z","caller":"traceutil/trace.go:171","msg":"trace[2111197496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25068; }","duration":"467.456039ms","start":"2026-05-08T11:12:57.751914Z","end":"2026-05-08T11:12:58.21937Z","steps":["trace[2111197496] 'agreement among raft nodes before linearized reading'  (duration: 467.265194ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.219112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.595875Z","time spent":"623.083422ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25052 > 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":"warn","ts":"2026-05-08T11:12:58.219415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.751832Z","time spent":"467.577692ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-08T11:12:58.219434Z","caller":"traceutil/trace.go:171","msg":"trace[2141481329] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:25068; }","duration":"105.407451ms","start":"2026-05-08T11:12:58.113999Z","end":"2026-05-08T11:12:58.219406Z","steps":["trace[2141481329] 'agreement among raft nodes before linearized reading'  (duration: 105.127714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:58.219229Z","caller":"traceutil/trace.go:171","msg":"trace[414102699] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25068; }","duration":"601.258423ms","start":"2026-05-08T11:12:57.617934Z","end":"2026-05-08T11:12:58.219193Z","steps":["trace[414102699] 'agreement among raft nodes before linearized reading'  (duration: 600.927506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.219543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.61791Z","time spent":"601.625593ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-08T11:12:58.218235Z","caller":"traceutil/trace.go:171","msg":"trace[679292937] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"286.761062ms","start":"2026-05-08T11:12:57.931443Z","end":"2026-05-08T11:12:58.218204Z","steps":["trace[679292937] 'process raft request'  (duration: 286.474495ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.219906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.842399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-05-08T11:12:58.219955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.923323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:12:58.220025Z","caller":"traceutil/trace.go:171","msg":"trace[1475161036] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:25068; }","duration":"114.012855ms","start":"2026-05-08T11:12:58.105993Z","end":"2026-05-08T11:12:58.220006Z","steps":["trace[1475161036] 'agreement among raft nodes before linearized reading'  (duration: 113.878782ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:58.220051Z","caller":"traceutil/trace.go:171","msg":"trace[1944226899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25068; }","duration":"468.019063ms","start":"2026-05-08T11:12:57.751971Z","end":"2026-05-08T11:12:58.21999Z","steps":["trace[1944226899] 'agreement among raft nodes before linearized reading'  (duration: 467.198673ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.220165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:57.751936Z","time spent":"468.214168ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-08T11:12:58.367995Z","caller":"traceutil/trace.go:171","msg":"trace[417165503] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"144.089049ms","start":"2026-05-08T11:12:58.223863Z","end":"2026-05-08T11:12:58.367952Z","steps":["trace[417165503] 'process raft request'  (duration: 125.032707ms)","trace[417165503] 'compare'  (duration: 18.502038ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:12:58.636187Z","caller":"traceutil/trace.go:171","msg":"trace[1092581023] linearizableReadLoop","detail":"{readStateIndex:25892; appliedIndex:25889; }","duration":"149.182269ms","start":"2026-05-08T11:12:58.486975Z","end":"2026-05-08T11:12:58.636157Z","steps":["trace[1092581023] 'read index received'  (duration: 130.409255ms)","trace[1092581023] 'applied index is now lower than readState.Index'  (duration: 18.771794ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:12:58.636207Z","caller":"traceutil/trace.go:171","msg":"trace[736360660] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"411.556953ms","start":"2026-05-08T11:12:58.224605Z","end":"2026-05-08T11:12:58.636162Z","steps":["trace[736360660] 'process raft request'  (duration: 392.82292ms)","trace[736360660] 'compare'  (duration: 18.203751ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:12:58.636373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.371614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T11:12:58.636383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:58.224587Z","time spent":"411.709938ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25053 > 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":"info","ts":"2026-05-08T11:12:58.636408Z","caller":"traceutil/trace.go:171","msg":"trace[714203412] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25072; }","duration":"149.474126ms","start":"2026-05-08T11:12:58.48692Z","end":"2026-05-08T11:12:58.636395Z","steps":["trace[714203412] 'agreement among raft nodes before linearized reading'  (duration: 149.347033ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:58.636428Z","caller":"traceutil/trace.go:171","msg":"trace[1075515473] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"411.713898ms","start":"2026-05-08T11:12:58.22468Z","end":"2026-05-08T11:12:58.636394Z","steps":["trace[1075515473] 'process raft request'  (duration: 411.309308ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:58.636448Z","caller":"traceutil/trace.go:171","msg":"trace[196853886] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"264.795671ms","start":"2026-05-08T11:12:58.371602Z","end":"2026-05-08T11:12:58.636398Z","steps":["trace[196853886] 'process raft request'  (duration: 264.492624ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:58.636859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:12:58.224651Z","time spent":"411.84596ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25055 > 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":"warn","ts":"2026-05-08T11:12:58.988314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.269303ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045130 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:24994 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:12:58.988444Z","caller":"traceutil/trace.go:171","msg":"trace[1886487286] linearizableReadLoop","detail":"{readStateIndex:25893; appliedIndex:25892; }","duration":"102.950813ms","start":"2026-05-08T11:12:58.88547Z","end":"2026-05-08T11:12:58.988421Z","steps":["trace[1886487286] 'read index received'  (duration: 100.332µs)","trace[1886487286] 'applied index is now lower than readState.Index'  (duration: 102.848771ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:12:58.988483Z","caller":"traceutil/trace.go:171","msg":"trace[2652301] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"214.670403ms","start":"2026-05-08T11:12:58.773778Z","end":"2026-05-08T11:12:58.988449Z","steps":["trace[2652301] 'process raft request'  (duration: 110.101453ms)","trace[2652301] 'compare'  (duration: 103.519666ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:12:58.988627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.166868ms","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-08T11:12:58.98867Z","caller":"traceutil/trace.go:171","msg":"trace[1162190879] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25073; }","duration":"103.25321ms","start":"2026-05-08T11:12:58.885401Z","end":"2026-05-08T11:12:58.988655Z","steps":["trace[1162190879] 'agreement among raft nodes before linearized reading'  (duration: 103.072886ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:59.153814Z","caller":"traceutil/trace.go:171","msg":"trace[932548383] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"159.73789ms","start":"2026-05-08T11:12:58.994045Z","end":"2026-05-08T11:12:59.153783Z","steps":["trace[932548383] 'process raft request'  (duration: 141.474367ms)","trace[932548383] 'compare'  (duration: 18.1404ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:12:59.222753Z","caller":"traceutil/trace.go:171","msg":"trace[2045884801] linearizableReadLoop","detail":"{readStateIndex:25895; appliedIndex:25893; }","duration":"204.554533ms","start":"2026-05-08T11:12:59.018166Z","end":"2026-05-08T11:12:59.22272Z","steps":["trace[2045884801] 'read index received'  (duration: 117.376255ms)","trace[2045884801] 'applied index is now lower than readState.Index'  (duration: 87.176737ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:12:59.223136Z","caller":"traceutil/trace.go:171","msg":"trace[1222588311] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"218.589826ms","start":"2026-05-08T11:12:59.004531Z","end":"2026-05-08T11:12:59.223121Z","steps":["trace[1222588311] 'process raft request'  (duration: 217.89349ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:59.223362Z","caller":"traceutil/trace.go:171","msg":"trace[1783799608] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"183.254707ms","start":"2026-05-08T11:12:59.040097Z","end":"2026-05-08T11:12:59.223352Z","steps":["trace[1783799608] 'process raft request'  (duration: 182.481169ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:59.223516Z","caller":"traceutil/trace.go:171","msg":"trace[813814998] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"180.79906ms","start":"2026-05-08T11:12:59.042669Z","end":"2026-05-08T11:12:59.223468Z","steps":["trace[813814998] 'process raft request'  (duration: 180.010572ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:12:59.223593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.413163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-08T11:12:59.223568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.9424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:12:59.223637Z","caller":"traceutil/trace.go:171","msg":"trace[1056432487] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:25078; }","duration":"205.516326ms","start":"2026-05-08T11:12:59.018108Z","end":"2026-05-08T11:12:59.223624Z","steps":["trace[1056432487] 'agreement among raft nodes before linearized reading'  (duration: 205.420733ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:59.223681Z","caller":"traceutil/trace.go:171","msg":"trace[1598628027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25078; }","duration":"116.131614ms","start":"2026-05-08T11:12:59.107519Z","end":"2026-05-08T11:12:59.22365Z","steps":["trace[1598628027] 'agreement among raft nodes before linearized reading'  (duration: 115.917859ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:12:59.223814Z","caller":"traceutil/trace.go:171","msg":"trace[2022580125] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"183.289118ms","start":"2026-05-08T11:12:59.040507Z","end":"2026-05-08T11:12:59.223796Z","steps":["trace[2022580125] 'process raft request'  (duration: 182.12281ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:04.565986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.947102ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045230 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25103 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:13:04.566099Z","caller":"traceutil/trace.go:171","msg":"trace[1809407896] linearizableReadLoop","detail":"{readStateIndex:25937; appliedIndex:25936; }","duration":"277.379851ms","start":"2026-05-08T11:13:04.288702Z","end":"2026-05-08T11:13:04.566082Z","steps":["trace[1809407896] 'read index received'  (duration: 107.204534ms)","trace[1809407896] 'applied index is now lower than readState.Index'  (duration: 170.173717ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:04.566142Z","caller":"traceutil/trace.go:171","msg":"trace[639074373] transaction","detail":"{read_only:false; response_revision:25116; number_of_response:1; }","duration":"303.680674ms","start":"2026-05-08T11:13:04.262436Z","end":"2026-05-08T11:13:04.566117Z","steps":["trace[639074373] 'process raft request'  (duration: 133.490806ms)","trace[639074373] 'compare'  (duration: 169.770268ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:04.566215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:04.262417Z","time spent":"303.769937ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25103 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:04.566381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.679158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-05-08T11:13:04.566451Z","caller":"traceutil/trace.go:171","msg":"trace[668028354] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:25116; }","duration":"277.79294ms","start":"2026-05-08T11:13:04.288638Z","end":"2026-05-08T11:13:04.56643Z","steps":["trace[668028354] 'agreement among raft nodes before linearized reading'  (duration: 277.538394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:04.566413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.043065ms","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-08T11:13:04.566584Z","caller":"traceutil/trace.go:171","msg":"trace[1560989871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25116; }","duration":"162.24596ms","start":"2026-05-08T11:13:04.404329Z","end":"2026-05-08T11:13:04.566575Z","steps":["trace[1560989871] 'agreement among raft nodes before linearized reading'  (duration: 161.930132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:04.793777Z","caller":"traceutil/trace.go:171","msg":"trace[1080539048] linearizableReadLoop","detail":"{readStateIndex:25939; appliedIndex:25938; }","duration":"133.585189ms","start":"2026-05-08T11:13:04.660156Z","end":"2026-05-08T11:13:04.793741Z","steps":["trace[1080539048] 'read index received'  (duration: 133.333153ms)","trace[1080539048] 'applied index is now lower than readState.Index'  (duration: 250.696µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:04.794144Z","caller":"traceutil/trace.go:171","msg":"trace[864653622] transaction","detail":"{read_only:false; response_revision:25118; number_of_response:1; }","duration":"136.610051ms","start":"2026-05-08T11:13:04.657515Z","end":"2026-05-08T11:13:04.794125Z","steps":["trace[864653622] 'process raft request'  (duration: 136.050487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:04.794597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.424329ms","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-08T11:13:04.794657Z","caller":"traceutil/trace.go:171","msg":"trace[1669014049] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25118; }","duration":"134.540642ms","start":"2026-05-08T11:13:04.660099Z","end":"2026-05-08T11:13:04.79464Z","steps":["trace[1669014049] 'agreement among raft nodes before linearized reading'  (duration: 134.345567ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:04.794871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.599676ms","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-08T11:13:04.794969Z","caller":"traceutil/trace.go:171","msg":"trace[1396694060] 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:25118; }","duration":"132.73081ms","start":"2026-05-08T11:13:04.662213Z","end":"2026-05-08T11:13:04.794944Z","steps":["trace[1396694060] 'agreement among raft nodes before linearized reading'  (duration: 132.516685ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:04.795261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.822437ms","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-08T11:13:04.795293Z","caller":"traceutil/trace.go:171","msg":"trace[563225503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25118; }","duration":"131.90646ms","start":"2026-05-08T11:13:04.663377Z","end":"2026-05-08T11:13:04.795283Z","steps":["trace[563225503] 'agreement among raft nodes before linearized reading'  (duration: 131.740336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:05.029993Z","caller":"traceutil/trace.go:171","msg":"trace[855412455] transaction","detail":"{read_only:false; response_revision:25119; number_of_response:1; }","duration":"230.230361ms","start":"2026-05-08T11:13:04.799727Z","end":"2026-05-08T11:13:05.029957Z","steps":["trace[855412455] 'process raft request'  (duration: 156.81819ms)","trace[855412455] 'compare'  (duration: 73.012032ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:05.030087Z","caller":"traceutil/trace.go:171","msg":"trace[1678948396] linearizableReadLoop","detail":"{readStateIndex:25940; appliedIndex:25939; }","duration":"229.438903ms","start":"2026-05-08T11:13:04.800619Z","end":"2026-05-08T11:13:05.030058Z","steps":["trace[1678948396] 'read index received'  (duration: 156.022611ms)","trace[1678948396] 'applied index is now lower than readState.Index'  (duration: 73.415072ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:05.03075Z","caller":"traceutil/trace.go:171","msg":"trace[1350673814] transaction","detail":"{read_only:false; response_revision:25120; number_of_response:1; }","duration":"228.454621ms","start":"2026-05-08T11:13:04.802279Z","end":"2026-05-08T11:13:05.030733Z","steps":["trace[1350673814] 'process raft request'  (duration: 227.632891ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:05.031065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.424807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:05.032336Z","caller":"traceutil/trace.go:171","msg":"trace[1440730124] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25120; }","duration":"231.724907ms","start":"2026-05-08T11:13:04.800589Z","end":"2026-05-08T11:13:05.032314Z","steps":["trace[1440730124] 'agreement among raft nodes before linearized reading'  (duration: 229.562716ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:05.031823Z","caller":"traceutil/trace.go:171","msg":"trace[777362571] transaction","detail":"{read_only:false; response_revision:25121; number_of_response:1; }","duration":"199.222747ms","start":"2026-05-08T11:13:04.832582Z","end":"2026-05-08T11:13:05.031804Z","steps":["trace[777362571] 'process raft request'  (duration: 198.09106ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:05.301127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.236101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-08T11:13:05.301233Z","caller":"traceutil/trace.go:171","msg":"trace[1781108864] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25121; }","duration":"117.386654ms","start":"2026-05-08T11:13:05.183822Z","end":"2026-05-08T11:13:05.301208Z","steps":["trace[1781108864] 'range keys from in-memory index tree'  (duration: 117.024086ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:05.44912Z","caller":"traceutil/trace.go:171","msg":"trace[1627567929] transaction","detail":"{read_only:false; response_revision:25122; number_of_response:1; }","duration":"202.435462ms","start":"2026-05-08T11:13:05.246658Z","end":"2026-05-08T11:13:05.449093Z","steps":["trace[1627567929] 'process raft request'  (duration: 202.299989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:05.645614Z","caller":"traceutil/trace.go:171","msg":"trace[1771304919] transaction","detail":"{read_only:false; response_revision:25125; number_of_response:1; }","duration":"394.530379ms","start":"2026-05-08T11:13:05.251051Z","end":"2026-05-08T11:13:05.645582Z","steps":["trace[1771304919] 'process raft request'  (duration: 394.463747ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:05.645726Z","caller":"traceutil/trace.go:171","msg":"trace[2032905204] transaction","detail":"{read_only:false; response_revision:25123; number_of_response:1; }","duration":"395.883352ms","start":"2026-05-08T11:13:05.249824Z","end":"2026-05-08T11:13:05.645708Z","steps":["trace[2032905204] 'process raft request'  (duration: 337.874956ms)","trace[2032905204] 'compare'  (duration: 57.546425ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:05.645774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:05.251037Z","time spent":"394.649953ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25110 > 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-08T11:13:05.645815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:05.249808Z","time spent":"395.958244ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25112 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T11:13:05.645918Z","caller":"traceutil/trace.go:171","msg":"trace[135606929] linearizableReadLoop","detail":"{readStateIndex:25946; appliedIndex:25943; }","duration":"371.049633ms","start":"2026-05-08T11:13:05.274858Z","end":"2026-05-08T11:13:05.645907Z","steps":["trace[135606929] 'read index received'  (duration: 174.8967ms)","trace[135606929] 'applied index is now lower than readState.Index'  (duration: 196.151693ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:05.645951Z","caller":"traceutil/trace.go:171","msg":"trace[146816502] transaction","detail":"{read_only:false; response_revision:25124; number_of_response:1; }","duration":"395.510914ms","start":"2026-05-08T11:13:05.250432Z","end":"2026-05-08T11:13:05.645943Z","steps":["trace[146816502] 'process raft request'  (duration: 395.024072ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:05.645987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:05.250401Z","time spent":"395.564126ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25111 > 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-08T11:13:05.646072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.227998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:05.646099Z","caller":"traceutil/trace.go:171","msg":"trace[43948138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25126; }","duration":"371.293729ms","start":"2026-05-08T11:13:05.274799Z","end":"2026-05-08T11:13:05.646093Z","steps":["trace[43948138] 'agreement among raft nodes before linearized reading'  (duration: 371.238018ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:05.64612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:05.274782Z","time spent":"371.33449ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-08T11:13:05.646224Z","caller":"traceutil/trace.go:171","msg":"trace[1537235077] transaction","detail":"{read_only:false; response_revision:25126; number_of_response:1; }","duration":"339.842443ms","start":"2026-05-08T11:13:05.306374Z","end":"2026-05-08T11:13:05.646216Z","steps":["trace[1537235077] 'process raft request'  (duration: 339.172517ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:05.646261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:05.306341Z","time spent":"339.901025ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25108 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:05.667303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.870835ms","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-08T11:13:05.667409Z","caller":"traceutil/trace.go:171","msg":"trace[1398254951] 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:25127; }","duration":"190.045329ms","start":"2026-05-08T11:13:05.477343Z","end":"2026-05-08T11:13:05.667388Z","steps":["trace[1398254951] 'agreement among raft nodes before linearized reading'  (duration: 189.836374ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:06.014922Z","caller":"traceutil/trace.go:171","msg":"trace[1820257020] transaction","detail":"{read_only:false; response_revision:25128; number_of_response:1; }","duration":"314.190564ms","start":"2026-05-08T11:13:05.700689Z","end":"2026-05-08T11:13:06.01488Z","steps":["trace[1820257020] 'process raft request'  (duration: 313.904487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:06.015164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:05.700616Z","time spent":"314.4299ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25088 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:06.38518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.694529ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045259 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25114 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:13:06.385386Z","caller":"traceutil/trace.go:171","msg":"trace[896552550] transaction","detail":"{read_only:false; response_revision:25129; number_of_response:1; }","duration":"365.365649ms","start":"2026-05-08T11:13:06.019994Z","end":"2026-05-08T11:13:06.38536Z","steps":["trace[896552550] 'process raft request'  (duration: 107.699386ms)","trace[896552550] 'compare'  (duration: 256.552116ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:06.385531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:06.019969Z","time spent":"365.487491ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25114 > 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-08T11:13:06.385759Z","caller":"traceutil/trace.go:171","msg":"trace[2134843316] linearizableReadLoop","detail":"{readStateIndex:25950; appliedIndex:25949; }","duration":"277.227347ms","start":"2026-05-08T11:13:06.108524Z","end":"2026-05-08T11:13:06.385751Z","steps":["trace[2134843316] 'read index received'  (duration: 19.174285ms)","trace[2134843316] 'applied index is now lower than readState.Index'  (duration: 258.052172ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:06.448894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.340844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:06.449072Z","caller":"traceutil/trace.go:171","msg":"trace[1247180947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25129; }","duration":"340.57062ms","start":"2026-05-08T11:13:06.10846Z","end":"2026-05-08T11:13:06.449031Z","steps":["trace[1247180947] 'agreement among raft nodes before linearized reading'  (duration: 277.34054ms)","trace[1247180947] 'range keys from in-memory index tree'  (duration: 63.008144ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:06.44914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:06.108437Z","time spent":"340.675352ms","remote":"127.0.0.1:51594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-08T11:13:06.449337Z","caller":"traceutil/trace.go:171","msg":"trace[495121905] transaction","detail":"{read_only:false; response_revision:25130; number_of_response:1; }","duration":"187.575961ms","start":"2026-05-08T11:13:06.261706Z","end":"2026-05-08T11:13:06.449282Z","steps":["trace[495121905] 'process raft request'  (duration: 187.210622ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:06.957898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.08784ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045267 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25117 > 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-08T11:13:06.958102Z","caller":"traceutil/trace.go:171","msg":"trace[521898824] transaction","detail":"{read_only:false; response_revision:25133; number_of_response:1; }","duration":"158.317906ms","start":"2026-05-08T11:13:06.799765Z","end":"2026-05-08T11:13:06.958083Z","steps":["trace[521898824] 'process raft request'  (duration: 158.247255ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:06.95839Z","caller":"traceutil/trace.go:171","msg":"trace[332772005] transaction","detail":"{read_only:false; response_revision:25132; number_of_response:1; }","duration":"306.823889ms","start":"2026-05-08T11:13:06.651523Z","end":"2026-05-08T11:13:06.958347Z","steps":["trace[332772005] 'process raft request'  (duration: 159.190176ms)","trace[332772005] 'compare'  (duration: 146.958907ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:06.958565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:06.65149Z","time spent":"306.988393ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25117 > 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":"info","ts":"2026-05-08T11:13:07.333996Z","caller":"traceutil/trace.go:171","msg":"trace[214960979] transaction","detail":"{read_only:false; response_revision:25134; number_of_response:1; }","duration":"295.863268ms","start":"2026-05-08T11:13:07.038097Z","end":"2026-05-08T11:13:07.33396Z","steps":["trace[214960979] 'process raft request'  (duration: 295.596982ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:07.356641Z","caller":"traceutil/trace.go:171","msg":"trace[1078455982] linearizableReadLoop","detail":"{readStateIndex:25957; appliedIndex:25955; }","duration":"249.360276ms","start":"2026-05-08T11:13:07.107252Z","end":"2026-05-08T11:13:07.356612Z","steps":["trace[1078455982] 'read index received'  (duration: 226.526574ms)","trace[1078455982] 'applied index is now lower than readState.Index'  (duration: 22.832862ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:07.356831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.55383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:07.356872Z","caller":"traceutil/trace.go:171","msg":"trace[120752765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25135; }","duration":"249.647033ms","start":"2026-05-08T11:13:07.107215Z","end":"2026-05-08T11:13:07.356862Z","steps":["trace[120752765] 'agreement among raft nodes before linearized reading'  (duration: 249.511769ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:07.3572Z","caller":"traceutil/trace.go:171","msg":"trace[1755319472] transaction","detail":"{read_only:false; response_revision:25135; number_of_response:1; }","duration":"319.003767ms","start":"2026-05-08T11:13:07.03813Z","end":"2026-05-08T11:13:07.357134Z","steps":["trace[1755319472] 'process raft request'  (duration: 318.341971ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:07.357462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:07.0381Z","time spent":"319.237304ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25119 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-08T11:13:07.863299Z","caller":"traceutil/trace.go:171","msg":"trace[1169657097] transaction","detail":"{read_only:false; response_revision:25138; number_of_response:1; }","duration":"209.814888ms","start":"2026-05-08T11:13:07.653447Z","end":"2026-05-08T11:13:07.863262Z","steps":["trace[1169657097] 'process raft request'  (duration: 184.225091ms)","trace[1169657097] 'compare'  (duration: 25.332361ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:07.863614Z","caller":"traceutil/trace.go:171","msg":"trace[1009177183] transaction","detail":"{read_only:false; response_revision:25141; number_of_response:1; }","duration":"186.874152ms","start":"2026-05-08T11:13:07.676711Z","end":"2026-05-08T11:13:07.863585Z","steps":["trace[1009177183] 'process raft request'  (duration: 186.828741ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:07.86361Z","caller":"traceutil/trace.go:171","msg":"trace[234058388] transaction","detail":"{read_only:false; response_revision:25139; number_of_response:1; }","duration":"210.063424ms","start":"2026-05-08T11:13:07.6535Z","end":"2026-05-08T11:13:07.863563Z","steps":["trace[234058388] 'process raft request'  (duration: 209.709596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:07.863642Z","caller":"traceutil/trace.go:171","msg":"trace[712146488] transaction","detail":"{read_only:false; response_revision:25140; number_of_response:1; }","duration":"189.752762ms","start":"2026-05-08T11:13:07.673853Z","end":"2026-05-08T11:13:07.863605Z","steps":["trace[712146488] 'process raft request'  (duration: 189.572668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:08.538389Z","caller":"traceutil/trace.go:171","msg":"trace[1212074738] transaction","detail":"{read_only:false; response_revision:25142; number_of_response:1; }","duration":"143.638097ms","start":"2026-05-08T11:13:08.394702Z","end":"2026-05-08T11:13:08.538341Z","steps":["trace[1212074738] 'process raft request'  (duration: 143.397301ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:08.588321Z","caller":"traceutil/trace.go:171","msg":"trace[1684437640] transaction","detail":"{read_only:false; response_revision:25143; number_of_response:1; }","duration":"132.124174ms","start":"2026-05-08T11:13:08.456156Z","end":"2026-05-08T11:13:08.58828Z","steps":["trace[1684437640] 'process raft request'  (duration: 131.873558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:08.773722Z","caller":"traceutil/trace.go:171","msg":"trace[209078111] linearizableReadLoop","detail":"{readStateIndex:25966; appliedIndex:25965; }","duration":"104.973459ms","start":"2026-05-08T11:13:08.668719Z","end":"2026-05-08T11:13:08.773693Z","steps":["trace[209078111] 'read index received'  (duration: 104.55203ms)","trace[209078111] 'applied index is now lower than readState.Index'  (duration: 420.219µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:08.773937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.194545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T11:13:08.773969Z","caller":"traceutil/trace.go:171","msg":"trace[603642028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25144; }","duration":"105.289267ms","start":"2026-05-08T11:13:08.668671Z","end":"2026-05-08T11:13:08.773961Z","steps":["trace[603642028] 'agreement among raft nodes before linearized reading'  (duration: 105.124683ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:08.774135Z","caller":"traceutil/trace.go:171","msg":"trace[355121527] transaction","detail":"{read_only:false; response_revision:25144; number_of_response:1; }","duration":"166.022258ms","start":"2026-05-08T11:13:08.608076Z","end":"2026-05-08T11:13:08.774098Z","steps":["trace[355121527] 'process raft request'  (duration: 165.427514ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:09.112096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.1743ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045301 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25131 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:13:09.112228Z","caller":"traceutil/trace.go:171","msg":"trace[251762008] linearizableReadLoop","detail":"{readStateIndex:25967; appliedIndex:25966; }","duration":"199.133005ms","start":"2026-05-08T11:13:08.913073Z","end":"2026-05-08T11:13:09.112206Z","steps":["trace[251762008] 'read index received'  (duration: 30.590436ms)","trace[251762008] 'applied index is now lower than readState.Index'  (duration: 168.541028ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:09.112352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.278448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:09.112328Z","caller":"traceutil/trace.go:171","msg":"trace[1982611372] transaction","detail":"{read_only:false; response_revision:25145; number_of_response:1; }","duration":"334.135956ms","start":"2026-05-08T11:13:08.778153Z","end":"2026-05-08T11:13:09.112289Z","steps":["trace[1982611372] 'process raft request'  (duration: 165.635259ms)","trace[1982611372] 'compare'  (duration: 168.040807ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:09.112388Z","caller":"traceutil/trace.go:171","msg":"trace[716108558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:25145; }","duration":"199.320268ms","start":"2026-05-08T11:13:08.913056Z","end":"2026-05-08T11:13:09.112376Z","steps":["trace[716108558] 'agreement among raft nodes before linearized reading'  (duration: 199.235677ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:09.112487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:08.778124Z","time spent":"334.27763ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25131 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:09.114703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.644492ms","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-08T11:13:09.114806Z","caller":"traceutil/trace.go:171","msg":"trace[1575870004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25146; }","duration":"152.807666ms","start":"2026-05-08T11:13:08.961976Z","end":"2026-05-08T11:13:09.114783Z","steps":["trace[1575870004] 'agreement among raft nodes before linearized reading'  (duration: 152.477338ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:09.115093Z","caller":"traceutil/trace.go:171","msg":"trace[914442356] transaction","detail":"{read_only:false; response_revision:25146; number_of_response:1; }","duration":"148.036412ms","start":"2026-05-08T11:13:08.966476Z","end":"2026-05-08T11:13:09.114512Z","steps":["trace[914442356] 'process raft request'  (duration: 147.791587ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:09.458348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.991663ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045305 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25132 > 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-08T11:13:09.458699Z","caller":"traceutil/trace.go:171","msg":"trace[606048920] linearizableReadLoop","detail":"{readStateIndex:25970; appliedIndex:25968; }","duration":"173.990298ms","start":"2026-05-08T11:13:09.284694Z","end":"2026-05-08T11:13:09.458684Z","steps":["trace[606048920] 'read index received'  (duration: 662.586µs)","trace[606048920] 'applied index is now lower than readState.Index'  (duration: 173.326802ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:09.458769Z","caller":"traceutil/trace.go:171","msg":"trace[791303430] transaction","detail":"{read_only:false; response_revision:25148; number_of_response:1; }","duration":"294.083897ms","start":"2026-05-08T11:13:09.164679Z","end":"2026-05-08T11:13:09.458763Z","steps":["trace[791303430] 'process raft request'  (duration: 293.960904ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:09.458845Z","caller":"traceutil/trace.go:171","msg":"trace[1820476105] transaction","detail":"{read_only:false; response_revision:25147; number_of_response:1; }","duration":"338.4697ms","start":"2026-05-08T11:13:09.120316Z","end":"2026-05-08T11:13:09.458785Z","steps":["trace[1820476105] 'process raft request'  (duration: 165.020885ms)","trace[1820476105] 'compare'  (duration: 172.84257ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:09.459038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.344686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:09.45906Z","caller":"traceutil/trace.go:171","msg":"trace[2053980754] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:25148; }","duration":"174.417628ms","start":"2026-05-08T11:13:09.284634Z","end":"2026-05-08T11:13:09.459052Z","steps":["trace[2053980754] 'agreement among raft nodes before linearized reading'  (duration: 174.380887ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:09.459073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.120284Z","time spent":"338.667085ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25132 > 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-08T11:13:09.459071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.036591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-08T11:13:09.459136Z","caller":"traceutil/trace.go:171","msg":"trace[1265255250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25148; }","duration":"121.163284ms","start":"2026-05-08T11:13:09.337956Z","end":"2026-05-08T11:13:09.45912Z","steps":["trace[1265255250] 'agreement among raft nodes before linearized reading'  (duration: 120.908048ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:09.652468Z","caller":"traceutil/trace.go:171","msg":"trace[1777935908] transaction","detail":"{read_only:false; response_revision:25149; number_of_response:1; }","duration":"189.157068ms","start":"2026-05-08T11:13:09.463272Z","end":"2026-05-08T11:13:09.652429Z","steps":["trace[1777935908] 'process raft request'  (duration: 160.356005ms)","trace[1777935908] 'compare'  (duration: 28.614009ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:09.871775Z","caller":"traceutil/trace.go:171","msg":"trace[1167325441] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"346.013778ms","start":"2026-05-08T11:13:09.525742Z","end":"2026-05-08T11:13:09.871755Z","steps":["trace[1167325441] 'process raft request'  (duration: 345.970847ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:09.871826Z","caller":"traceutil/trace.go:171","msg":"trace[1899405979] transaction","detail":"{read_only:false; response_revision:25150; number_of_response:1; }","duration":"407.818884ms","start":"2026-05-08T11:13:09.463959Z","end":"2026-05-08T11:13:09.871778Z","steps":["trace[1899405979] 'process raft request'  (duration: 407.62083ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:09.871942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.525709Z","time spent":"346.133241ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25136 > 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":"warn","ts":"2026-05-08T11:13:09.872064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.463929Z","time spent":"408.00891ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25134 > 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":"info","ts":"2026-05-08T11:13:10.219702Z","caller":"traceutil/trace.go:171","msg":"trace[804079852] linearizableReadLoop","detail":"{readStateIndex:25976; appliedIndex:25972; }","duration":"349.386368ms","start":"2026-05-08T11:13:09.870294Z","end":"2026-05-08T11:13:10.219681Z","steps":["trace[804079852] 'read index received'  (duration: 1.426733ms)","trace[804079852] 'applied index is now lower than readState.Index'  (duration: 347.958535ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:10.220028Z","caller":"traceutil/trace.go:171","msg":"trace[593689382] transaction","detail":"{read_only:false; response_revision:25155; number_of_response:1; }","duration":"349.358717ms","start":"2026-05-08T11:13:09.870589Z","end":"2026-05-08T11:13:10.219948Z","steps":["trace[593689382] 'process raft request'  (duration: 349.05257ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:10.220088Z","caller":"traceutil/trace.go:171","msg":"trace[1401006209] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"350.620248ms","start":"2026-05-08T11:13:09.869453Z","end":"2026-05-08T11:13:10.220073Z","steps":["trace[1401006209] 'process raft request'  (duration: 350.103816ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:10.220141Z","caller":"traceutil/trace.go:171","msg":"trace[1297686603] transaction","detail":"{read_only:false; response_revision:25152; number_of_response:1; }","duration":"541.677511ms","start":"2026-05-08T11:13:09.678423Z","end":"2026-05-08T11:13:10.2201Z","steps":["trace[1297686603] 'process raft request'  (duration: 540.954474ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:10.220223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.86942Z","time spent":"350.70462ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25139 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-08T11:13:10.220255Z","caller":"traceutil/trace.go:171","msg":"trace[315613234] transaction","detail":"{read_only:false; response_revision:25154; number_of_response:1; }","duration":"350.021644ms","start":"2026-05-08T11:13:09.870197Z","end":"2026-05-08T11:13:10.220219Z","steps":["trace[315613234] 'process raft request'  (duration: 349.405659ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:10.220358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.678394Z","time spent":"541.838864ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25137 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:10.220508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.870182Z","time spent":"350.208269ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25138 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:10.220793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.870572Z","time spent":"350.096446ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25140 > 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":"warn","ts":"2026-05-08T11:13:10.220184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.306173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:10.22098Z","caller":"traceutil/trace.go:171","msg":"trace[1565564153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25155; }","duration":"110.251997ms","start":"2026-05-08T11:13:10.110706Z","end":"2026-05-08T11:13:10.220958Z","steps":["trace[1565564153] 'agreement among raft nodes before linearized reading'  (duration: 109.303554ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:10.220902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.605458ms","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-08T11:13:10.221093Z","caller":"traceutil/trace.go:171","msg":"trace[1796662703] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25155; }","duration":"350.794573ms","start":"2026-05-08T11:13:09.87028Z","end":"2026-05-08T11:13:10.221074Z","steps":["trace[1796662703] 'agreement among raft nodes before linearized reading'  (duration: 349.751197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:10.221135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:09.870201Z","time spent":"350.924195ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-08T11:13:10.536209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.892374ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558045319 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25141 > 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-08T11:13:10.536377Z","caller":"traceutil/trace.go:171","msg":"trace[1193593759] transaction","detail":"{read_only:false; response_revision:25156; number_of_response:1; }","duration":"310.147647ms","start":"2026-05-08T11:13:10.226196Z","end":"2026-05-08T11:13:10.536344Z","steps":["trace[1193593759] 'process raft request'  (duration: 147.010047ms)","trace[1193593759] 'compare'  (duration: 162.746201ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:10.536479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:10.226183Z","time spent":"310.248129ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25141 > 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":"info","ts":"2026-05-08T11:13:10.723243Z","caller":"traceutil/trace.go:171","msg":"trace[1163440526] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"128.382805ms","start":"2026-05-08T11:13:10.594815Z","end":"2026-05-08T11:13:10.723198Z","steps":["trace[1163440526] 'process raft request'  (duration: 126.287445ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:11.063861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.008302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.35\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-08T11:13:11.063941Z","caller":"traceutil/trace.go:171","msg":"trace[1395723944] range","detail":"{range_begin:/registry/masterleases/199.19.213.35; range_end:; response_count:1; response_revision:25158; }","duration":"218.158986ms","start":"2026-05-08T11:13:10.845763Z","end":"2026-05-08T11:13:11.063922Z","steps":["trace[1395723944] 'range keys from in-memory index tree'  (duration: 217.741806ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:11.242001Z","caller":"traceutil/trace.go:171","msg":"trace[264615395] linearizableReadLoop","detail":"{readStateIndex:25982; appliedIndex:25981; }","duration":"124.308168ms","start":"2026-05-08T11:13:11.117654Z","end":"2026-05-08T11:13:11.241962Z","steps":["trace[264615395] 'read index received'  (duration: 109.562239ms)","trace[264615395] 'applied index is now lower than readState.Index'  (duration: 14.744139ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:11.242218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.542665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T11:13:11.242248Z","caller":"traceutil/trace.go:171","msg":"trace[1241038337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25159; }","duration":"124.626556ms","start":"2026-05-08T11:13:11.117611Z","end":"2026-05-08T11:13:11.242238Z","steps":["trace[1241038337] 'agreement among raft nodes before linearized reading'  (duration: 124.522933ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:11.447872Z","caller":"traceutil/trace.go:171","msg":"trace[1530653284] linearizableReadLoop","detail":"{readStateIndex:25983; appliedIndex:25982; }","duration":"205.734891ms","start":"2026-05-08T11:13:11.242104Z","end":"2026-05-08T11:13:11.447839Z","steps":["trace[1530653284] 'read index received'  (duration: 205.628279ms)","trace[1530653284] 'applied index is now lower than readState.Index'  (duration: 104.502µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:11.447936Z","caller":"traceutil/trace.go:171","msg":"trace[847273564] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"326.292181ms","start":"2026-05-08T11:13:11.121604Z","end":"2026-05-08T11:13:11.447897Z","steps":["trace[847273564] 'process raft request'  (duration: 326.026325ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:11.448078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.51835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T11:13:11.448124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:11.121579Z","time spent":"326.434005ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25146 > 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-08T11:13:11.448141Z","caller":"traceutil/trace.go:171","msg":"trace[1786803396] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:25160; }","duration":"257.658523ms","start":"2026-05-08T11:13:11.190467Z","end":"2026-05-08T11:13:11.448125Z","steps":["trace[1786803396] 'agreement among raft nodes before linearized reading'  (duration: 257.501689ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:11.448703Z","caller":"traceutil/trace.go:171","msg":"trace[1508867464] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"205.063965ms","start":"2026-05-08T11:13:11.243618Z","end":"2026-05-08T11:13:11.448682Z","steps":["trace[1508867464] 'process raft request'  (duration: 204.530252ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:11.448697Z","caller":"traceutil/trace.go:171","msg":"trace[1081175734] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"201.398448ms","start":"2026-05-08T11:13:11.247271Z","end":"2026-05-08T11:13:11.44867Z","steps":["trace[1081175734] 'process raft request'  (duration: 201.333857ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:11.606293Z","caller":"traceutil/trace.go:171","msg":"trace[919011898] transaction","detail":"{read_only:false; response_revision:25163; number_of_response:1; }","duration":"138.295951ms","start":"2026-05-08T11:13:11.467966Z","end":"2026-05-08T11:13:11.606262Z","steps":["trace[919011898] 'process raft request'  (duration: 137.029121ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:15.965343Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15855096241558045397,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-08T11:13:16.458533Z","caller":"traceutil/trace.go:171","msg":"trace[227171625] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"996.147031ms","start":"2026-05-08T11:13:15.462352Z","end":"2026-05-08T11:13:16.4585Z","steps":["trace[227171625] 'process raft request'  (duration: 995.944527ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.458734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.462324Z","time spent":"996.299385ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25175 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T11:13:16.554247Z","caller":"traceutil/trace.go:171","msg":"trace[501175578] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"660.338745ms","start":"2026-05-08T11:13:15.893875Z","end":"2026-05-08T11:13:16.554214Z","steps":["trace[501175578] 'process raft request'  (duration: 660.081049ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.554449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.893847Z","time spent":"660.49777ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25179 > 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-08T11:13:16.554642Z","caller":"traceutil/trace.go:171","msg":"trace[1804351274] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"313.262491ms","start":"2026-05-08T11:13:16.24136Z","end":"2026-05-08T11:13:16.554623Z","steps":["trace[1804351274] 'process raft request'  (duration: 313.101958ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:16.554766Z","caller":"traceutil/trace.go:171","msg":"trace[1408519095] transaction","detail":"{read_only:false; response_revision:25192; number_of_response:1; }","duration":"310.560697ms","start":"2026-05-08T11:13:16.244194Z","end":"2026-05-08T11:13:16.554755Z","steps":["trace[1408519095] 'process raft request'  (duration: 310.387273ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.554785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:16.241334Z","time spent":"313.368704ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25181 > 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\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:16.554829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:16.244178Z","time spent":"310.613689ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25183 > 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":"info","ts":"2026-05-08T11:13:16.555113Z","caller":"traceutil/trace.go:171","msg":"trace[704151833] transaction","detail":"{read_only:false; response_revision:25193; number_of_response:1; }","duration":"308.865016ms","start":"2026-05-08T11:13:16.246235Z","end":"2026-05-08T11:13:16.5551Z","steps":["trace[704151833] 'process raft request'  (duration: 308.475157ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.555161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:16.246218Z","time spent":"308.917808ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25182 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T11:13:16.554626Z","caller":"traceutil/trace.go:171","msg":"trace[1492611919] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"473.225817ms","start":"2026-05-08T11:13:16.081367Z","end":"2026-05-08T11:13:16.554593Z","steps":["trace[1492611919] 'process raft request'  (duration: 472.770385ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:16.555341Z","caller":"traceutil/trace.go:171","msg":"trace[96573503] transaction","detail":"{read_only:false; response_revision:25194; number_of_response:1; }","duration":"309.034151ms","start":"2026-05-08T11:13:16.24624Z","end":"2026-05-08T11:13:16.555275Z","steps":["trace[96573503] 'process raft request'  (duration: 308.762634ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.555567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:16.246222Z","time spent":"309.222345ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25184 > 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-08T11:13:16.556197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:16.081337Z","time spent":"473.979104ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25159 > 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-08T11:13:16.55985Z","caller":"traceutil/trace.go:171","msg":"trace[2084191314] linearizableReadLoop","detail":"{readStateIndex:26012; appliedIndex:26010; }","duration":"1.095197312s","start":"2026-05-08T11:13:15.464614Z","end":"2026-05-08T11:13:16.559812Z","steps":["trace[2084191314] 'read index received'  (duration: 993.754505ms)","trace[2084191314] 'applied index is now lower than readState.Index'  (duration: 101.440936ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:16.560433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095788746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T11:13:16.560495Z","caller":"traceutil/trace.go:171","msg":"trace[1528234984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25194; }","duration":"1.095904559s","start":"2026-05-08T11:13:15.464572Z","end":"2026-05-08T11:13:16.560477Z","steps":["trace[1528234984] 'agreement among raft nodes before linearized reading'  (duration: 1.095671304s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.560547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.464561Z","time spent":"1.09597432s","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-08T11:13:16.560656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.968196ms","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-08T11:13:16.560705Z","caller":"traceutil/trace.go:171","msg":"trace[286705078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25194; }","duration":"939.079538ms","start":"2026-05-08T11:13:15.621612Z","end":"2026-05-08T11:13:16.560691Z","steps":["trace[286705078] 'agreement among raft nodes before linearized reading'  (duration: 938.898084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.560736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.621586Z","time spent":"939.14359ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-08T11:13:16.560875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.169792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:16.560904Z","caller":"traceutil/trace.go:171","msg":"trace[386783861] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:25194; }","duration":"115.203043ms","start":"2026-05-08T11:13:16.445694Z","end":"2026-05-08T11:13:16.560897Z","steps":["trace[386783861] 'agreement among raft nodes before linearized reading'  (duration: 115.133641ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.570439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:16.561087Z","caller":"traceutil/trace.go:171","msg":"trace[1272330106] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25194; }","duration":"141.647971ms","start":"2026-05-08T11:13:16.419428Z","end":"2026-05-08T11:13:16.561076Z","steps":["trace[1272330106] 'agreement among raft nodes before linearized reading'  (duration: 141.60088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.776271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:16.561249Z","caller":"traceutil/trace.go:171","msg":"trace[1626023395] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:25194; }","duration":"154.806243ms","start":"2026-05-08T11:13:16.406435Z","end":"2026-05-08T11:13:16.561242Z","steps":["trace[1626023395] 'agreement among raft nodes before linearized reading'  (duration: 154.763292ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.984836ms","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:6"}
{"level":"info","ts":"2026-05-08T11:13:16.561559Z","caller":"traceutil/trace.go:171","msg":"trace[1377039773] 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:25194; }","duration":"343.072859ms","start":"2026-05-08T11:13:16.218476Z","end":"2026-05-08T11:13:16.561549Z","steps":["trace[1377039773] 'agreement among raft nodes before linearized reading'  (duration: 343.006598ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.527544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"warn","ts":"2026-05-08T11:13:16.561592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:16.218455Z","time spent":"343.12679ms","remote":"127.0.0.1:53698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "}
{"level":"info","ts":"2026-05-08T11:13:16.561616Z","caller":"traceutil/trace.go:171","msg":"trace[1183202254] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25194; }","duration":"919.625196ms","start":"2026-05-08T11:13:15.641978Z","end":"2026-05-08T11:13:16.561603Z","steps":["trace[1183202254] 'agreement among raft nodes before linearized reading'  (duration: 919.426612ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.641956Z","time spent":"919.696479ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":586,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-05-08T11:13:16.561688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.910574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"warn","ts":"2026-05-08T11:13:16.561589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.652216ms","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-08T11:13:16.561797Z","caller":"traceutil/trace.go:171","msg":"trace[1144531778] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:25194; }","duration":"677.885722ms","start":"2026-05-08T11:13:15.883874Z","end":"2026-05-08T11:13:16.561759Z","steps":["trace[1144531778] 'agreement among raft nodes before linearized reading'  (duration: 677.474302ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.346007ms","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":"warn","ts":"2026-05-08T11:13:16.56183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.883848Z","time spent":"677.970993ms","remote":"127.0.0.1:51900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":175,"response size":33,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"info","ts":"2026-05-08T11:13:16.561874Z","caller":"traceutil/trace.go:171","msg":"trace[2006788824] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25194; }","duration":"623.565443ms","start":"2026-05-08T11:13:15.938286Z","end":"2026-05-08T11:13:16.561852Z","steps":["trace[2006788824] 'agreement among raft nodes before linearized reading'  (duration: 623.349318ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.561904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.072131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-05-08T11:13:16.561915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.938261Z","time spent":"623.645764ms","remote":"127.0.0.1:49728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true "}
{"level":"info","ts":"2026-05-08T11:13:16.561931Z","caller":"traceutil/trace.go:171","msg":"trace[279967912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25194; }","duration":"881.132843ms","start":"2026-05-08T11:13:15.680791Z","end":"2026-05-08T11:13:16.561923Z","steps":["trace[279967912] 'agreement among raft nodes before linearized reading'  (duration: 881.054091ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:16.561751Z","caller":"traceutil/trace.go:171","msg":"trace[1615206392] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25194; }","duration":"238.023926ms","start":"2026-05-08T11:13:16.323705Z","end":"2026-05-08T11:13:16.561729Z","steps":["trace[1615206392] 'agreement among raft nodes before linearized reading'  (duration: 237.860623ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.562013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.219957ms","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-08T11:13:16.562063Z","caller":"traceutil/trace.go:171","msg":"trace[1394723823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25194; }","duration":"661.320839ms","start":"2026-05-08T11:13:15.900731Z","end":"2026-05-08T11:13:16.562052Z","steps":["trace[1394723823] 'agreement among raft nodes before linearized reading'  (duration: 661.118954ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:16.562085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.900712Z","time spent":"661.36914ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-08T11:13:16.561957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:15.680772Z","time spent":"881.180975ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-08T11:13:23.760206Z","caller":"traceutil/trace.go:171","msg":"trace[1296320915] linearizableReadLoop","detail":"{readStateIndex:26134; appliedIndex:26133; }","duration":"276.306445ms","start":"2026-05-08T11:13:23.48387Z","end":"2026-05-08T11:13:23.760177Z","steps":["trace[1296320915] 'read index received'  (duration: 276.099981ms)","trace[1296320915] 'applied index is now lower than readState.Index'  (duration: 205.424µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:23.760573Z","caller":"traceutil/trace.go:171","msg":"trace[1376450278] transaction","detail":"{read_only:false; response_revision:25309; number_of_response:1; }","duration":"464.95965ms","start":"2026-05-08T11:13:23.295593Z","end":"2026-05-08T11:13:23.760553Z","steps":["trace[1376450278] 'process raft request'  (duration: 464.441668ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:23.76073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:23.295571Z","time spent":"465.054513ms","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52460d69-1073-476b-a0e8-9f7e6e6a5d0e\" mod_revision:25280 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52460d69-1073-476b-a0e8-9f7e6e6a5d0e\" value_size:3645 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52460d69-1073-476b-a0e8-9f7e6e6a5d0e\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:23.761062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.184516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T11:13:23.761122Z","caller":"traceutil/trace.go:171","msg":"trace[599083269] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:25309; }","duration":"277.293369ms","start":"2026-05-08T11:13:23.483811Z","end":"2026-05-08T11:13:23.761104Z","steps":["trace[599083269] 'agreement among raft nodes before linearized reading'  (duration: 277.179706ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:24.034718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.037359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:24.034836Z","caller":"traceutil/trace.go:171","msg":"trace[566463027] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:25309; }","duration":"201.216634ms","start":"2026-05-08T11:13:23.833593Z","end":"2026-05-08T11:13:24.034809Z","steps":["trace[566463027] 'count revisions from in-memory index tree'  (duration: 200.912247ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:29.757728Z","caller":"traceutil/trace.go:171","msg":"trace[2049007283] linearizableReadLoop","detail":"{readStateIndex:26197; appliedIndex:26196; }","duration":"238.309814ms","start":"2026-05-08T11:13:29.519385Z","end":"2026-05-08T11:13:29.757695Z","steps":["trace[2049007283] 'read index received'  (duration: 238.13575ms)","trace[2049007283] 'applied index is now lower than readState.Index'  (duration: 172.834µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:29.757871Z","caller":"traceutil/trace.go:171","msg":"trace[1897191466] transaction","detail":"{read_only:false; response_revision:25370; number_of_response:1; }","duration":"313.269272ms","start":"2026-05-08T11:13:29.444538Z","end":"2026-05-08T11:13:29.757808Z","steps":["trace[1897191466] 'process raft request'  (duration: 312.917754ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:29.758009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.247349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T11:13:29.758066Z","caller":"traceutil/trace.go:171","msg":"trace[833967694] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:25370; }","duration":"237.386682ms","start":"2026-05-08T11:13:29.520665Z","end":"2026-05-08T11:13:29.758052Z","steps":["trace[833967694] 'agreement among raft nodes before linearized reading'  (duration: 237.242499ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:29.758065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.657252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"warn","ts":"2026-05-08T11:13:29.758116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:29.444509Z","time spent":"313.493598ms","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10633,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" mod_revision:25350 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" value_size:10576 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" > >"}
{"level":"info","ts":"2026-05-08T11:13:29.758153Z","caller":"traceutil/trace.go:171","msg":"trace[862341533] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25370; }","duration":"238.815706ms","start":"2026-05-08T11:13:29.519314Z","end":"2026-05-08T11:13:29.75813Z","steps":["trace[862341533] 'agreement among raft nodes before linearized reading'  (duration: 238.54943ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:54.940359Z","caller":"traceutil/trace.go:171","msg":"trace[1429162872] transaction","detail":"{read_only:false; response_revision:25574; number_of_response:1; }","duration":"240.857084ms","start":"2026-05-08T11:13:54.699472Z","end":"2026-05-08T11:13:54.940329Z","steps":["trace[1429162872] 'process raft request'  (duration: 240.594968ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:55.173282Z","caller":"traceutil/trace.go:171","msg":"trace[1460749321] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"469.089899ms","start":"2026-05-08T11:13:54.70416Z","end":"2026-05-08T11:13:55.17325Z","steps":["trace[1460749321] 'process raft request'  (duration: 468.744391ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.17369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.704135Z","time spent":"469.440616ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25562 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T11:13:55.173694Z","caller":"traceutil/trace.go:171","msg":"trace[124652019] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"469.403005ms","start":"2026-05-08T11:13:54.704254Z","end":"2026-05-08T11:13:55.173657Z","steps":["trace[124652019] 'process raft request'  (duration: 468.923094ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:55.173871Z","caller":"traceutil/trace.go:171","msg":"trace[785151892] linearizableReadLoop","detail":"{readStateIndex:26411; appliedIndex:26407; }","duration":"417.497395ms","start":"2026-05-08T11:13:54.756351Z","end":"2026-05-08T11:13:55.173848Z","steps":["trace[785151892] 'read index received'  (duration: 184.459456ms)","trace[785151892] 'applied index is now lower than readState.Index'  (duration: 233.036409ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:55.173957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.704247Z","time spent":"469.523189ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25563 > 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-08T11:13:55.173991Z","caller":"traceutil/trace.go:171","msg":"trace[2015292044] transaction","detail":"{read_only:false; response_revision:25578; number_of_response:1; }","duration":"467.540451ms","start":"2026-05-08T11:13:54.706406Z","end":"2026-05-08T11:13:55.173946Z","steps":["trace[2015292044] 'process raft request'  (duration: 467.353937ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:55.173989Z","caller":"traceutil/trace.go:171","msg":"trace[1687712486] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"467.589133ms","start":"2026-05-08T11:13:54.706334Z","end":"2026-05-08T11:13:55.173923Z","steps":["trace[1687712486] 'process raft request'  (duration: 467.178483ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.174084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.712101ms","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-08T11:13:55.174147Z","caller":"traceutil/trace.go:171","msg":"trace[1128629392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25578; }","duration":"417.832433ms","start":"2026-05-08T11:13:54.756298Z","end":"2026-05-08T11:13:55.174131Z","steps":["trace[1128629392] 'agreement among raft nodes before linearized reading'  (duration: 417.657978ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.174202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.756276Z","time spent":"417.909386ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-08T11:13:55.174195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.706378Z","time spent":"467.706596ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25564 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:55.174224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.706316Z","time spent":"467.793808ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25565 > 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":"warn","ts":"2026-05-08T11:13:55.518684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.405941ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558046383 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25572 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:13:55.518823Z","caller":"traceutil/trace.go:171","msg":"trace[1173401049] linearizableReadLoop","detail":"{readStateIndex:26412; appliedIndex:26411; }","duration":"344.864582ms","start":"2026-05-08T11:13:55.173938Z","end":"2026-05-08T11:13:55.518802Z","steps":["trace[1173401049] 'read index received'  (duration: 177.172144ms)","trace[1173401049] 'applied index is now lower than readState.Index'  (duration: 167.690738ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:55.519016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.607971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T11:13:55.519047Z","caller":"traceutil/trace.go:171","msg":"trace[1688819939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25579; }","duration":"759.680603ms","start":"2026-05-08T11:13:54.759356Z","end":"2026-05-08T11:13:55.519037Z","steps":["trace[1688819939] 'agreement among raft nodes before linearized reading'  (duration: 759.52708ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.519056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.077348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T11:13:55.519088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.759329Z","time spent":"759.746904ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-08T11:13:55.519067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.46365ms","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-08T11:13:55.519109Z","caller":"traceutil/trace.go:171","msg":"trace[1422253764] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:25579; }","duration":"528.171141ms","start":"2026-05-08T11:13:54.99092Z","end":"2026-05-08T11:13:55.519091Z","steps":["trace[1422253764] 'agreement among raft nodes before linearized reading'  (duration: 528.074968ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.519152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.252766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-05-08T11:13:55.519045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.856104ms","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-08T11:13:55.519161Z","caller":"traceutil/trace.go:171","msg":"trace[293799395] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25579; }","duration":"749.622264ms","start":"2026-05-08T11:13:54.769514Z","end":"2026-05-08T11:13:55.519137Z","steps":["trace[293799395] 'agreement among raft nodes before linearized reading'  (duration: 749.360748ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:55.519065Z","caller":"traceutil/trace.go:171","msg":"trace[1634799638] transaction","detail":"{read_only:false; response_revision:25579; number_of_response:1; }","duration":"518.403428ms","start":"2026-05-08T11:13:55.000612Z","end":"2026-05-08T11:13:55.519016Z","steps":["trace[1634799638] 'process raft request'  (duration: 350.553966ms)","trace[1634799638] 'compare'  (duration: 167.223836ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:55.51919Z","caller":"traceutil/trace.go:171","msg":"trace[789786546] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25579; }","duration":"760.335049ms","start":"2026-05-08T11:13:54.758845Z","end":"2026-05-08T11:13:55.51918Z","steps":["trace[789786546] 'agreement among raft nodes before linearized reading'  (duration: 760.213766ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.519212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.758817Z","time spent":"760.389049ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-08T11:13:55.519218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.769488Z","time spent":"749.718286ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-08T11:13:55.519237Z","caller":"traceutil/trace.go:171","msg":"trace[367485452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25579; }","duration":"754.092609ms","start":"2026-05-08T11:13:54.765104Z","end":"2026-05-08T11:13:55.519197Z","steps":["trace[367485452] 'agreement among raft nodes before linearized reading'  (duration: 753.747881ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.519269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:55.00058Z","time spent":"518.628763ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25572 > 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":"warn","ts":"2026-05-08T11:13:55.519171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.990899Z","time spent":"528.261052ms","remote":"127.0.0.1:49342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T11:13:55.518992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.917096ms","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-08T11:13:55.519329Z","caller":"traceutil/trace.go:171","msg":"trace[288034362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25579; }","duration":"703.313965ms","start":"2026-05-08T11:13:54.816002Z","end":"2026-05-08T11:13:55.519316Z","steps":["trace[288034362] 'agreement among raft nodes before linearized reading'  (duration: 702.846884ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.519352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.815982Z","time spent":"703.362017ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-08T11:13:55.519571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:54.765079Z","time spent":"754.190312ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-08T11:13:55.610001Z","caller":"traceutil/trace.go:171","msg":"trace[291292521] transaction","detail":"{read_only:false; response_revision:25580; number_of_response:1; }","duration":"430.198125ms","start":"2026-05-08T11:13:55.179766Z","end":"2026-05-08T11:13:55.609964Z","steps":["trace[291292521] 'process raft request'  (duration: 429.97915ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.610033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.696718ms","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-08T11:13:55.610117Z","caller":"traceutil/trace.go:171","msg":"trace[451788319] 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:25580; }","duration":"430.79953ms","start":"2026-05-08T11:13:55.179294Z","end":"2026-05-08T11:13:55.610094Z","steps":["trace[451788319] 'agreement among raft nodes before linearized reading'  (duration: 430.595686ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.610153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:55.179223Z","time spent":"430.922124ms","remote":"127.0.0.1:49672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-05-08T11:13:55.610114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.237568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:55.610235Z","caller":"traceutil/trace.go:171","msg":"trace[1824966723] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:25580; }","duration":"124.438232ms","start":"2026-05-08T11:13:55.485773Z","end":"2026-05-08T11:13:55.610212Z","steps":["trace[1824966723] 'agreement among raft nodes before linearized reading'  (duration: 124.194576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.610328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:55.179739Z","time spent":"430.358659ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25566 > 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":"warn","ts":"2026-05-08T11:13:55.610436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.411685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:55.610546Z","caller":"traceutil/trace.go:171","msg":"trace[1964225242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25580; }","duration":"337.589348ms","start":"2026-05-08T11:13:55.272931Z","end":"2026-05-08T11:13:55.610521Z","steps":["trace[1964225242] 'agreement among raft nodes before linearized reading'  (duration: 337.418004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:55.610602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:55.272902Z","time spent":"337.689601ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-08T11:13:56.836767Z","caller":"traceutil/trace.go:171","msg":"trace[469964498] transaction","detail":"{read_only:false; response_revision:25586; number_of_response:1; }","duration":"218.266188ms","start":"2026-05-08T11:13:56.61847Z","end":"2026-05-08T11:13:56.836736Z","steps":["trace[469964498] 'process raft request'  (duration: 218.077974ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:56.943175Z","caller":"traceutil/trace.go:171","msg":"trace[1559592041] transaction","detail":"{read_only:false; response_revision:25587; number_of_response:1; }","duration":"307.663419ms","start":"2026-05-08T11:13:56.635477Z","end":"2026-05-08T11:13:56.943141Z","steps":["trace[1559592041] 'process raft request'  (duration: 216.819295ms)","trace[1559592041] 'compare'  (duration: 90.66423ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:56.943372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:56.635449Z","time spent":"307.816502ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25573 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T11:13:57.395098Z","caller":"traceutil/trace.go:171","msg":"trace[593463135] transaction","detail":"{read_only:false; response_revision:25591; number_of_response:1; }","duration":"213.923975ms","start":"2026-05-08T11:13:57.181157Z","end":"2026-05-08T11:13:57.395081Z","steps":["trace[593463135] 'process raft request'  (duration: 213.799492ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:57.395345Z","caller":"traceutil/trace.go:171","msg":"trace[894899276] transaction","detail":"{read_only:false; response_revision:25592; number_of_response:1; }","duration":"214.14438ms","start":"2026-05-08T11:13:57.181182Z","end":"2026-05-08T11:13:57.395327Z","steps":["trace[894899276] 'process raft request'  (duration: 213.839903ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:57.395092Z","caller":"traceutil/trace.go:171","msg":"trace[1751160105] transaction","detail":"{read_only:false; response_revision:25590; number_of_response:1; }","duration":"213.930235ms","start":"2026-05-08T11:13:57.18111Z","end":"2026-05-08T11:13:57.39504Z","steps":["trace[1751160105] 'process raft request'  (duration: 204.132983ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:57.395288Z","caller":"traceutil/trace.go:171","msg":"trace[277980944] linearizableReadLoop","detail":"{readStateIndex:26426; appliedIndex:26422; }","duration":"211.989458ms","start":"2026-05-08T11:13:57.183237Z","end":"2026-05-08T11:13:57.395226Z","steps":["trace[277980944] 'read index received'  (duration: 17.544536ms)","trace[277980944] 'applied index is now lower than readState.Index'  (duration: 194.442562ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:57.39562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.269156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:57.3957Z","caller":"traceutil/trace.go:171","msg":"trace[1405629536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25592; }","duration":"212.486511ms","start":"2026-05-08T11:13:57.183199Z","end":"2026-05-08T11:13:57.395685Z","steps":["trace[1405629536] 'agreement among raft nodes before linearized reading'  (duration: 212.229584ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:57.395896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.196262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:57.39598Z","caller":"traceutil/trace.go:171","msg":"trace[771351945] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25592; }","duration":"128.373715ms","start":"2026-05-08T11:13:57.267582Z","end":"2026-05-08T11:13:57.395956Z","steps":["trace[771351945] 'agreement among raft nodes before linearized reading'  (duration: 128.209402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:57.689617Z","caller":"traceutil/trace.go:171","msg":"trace[564045796] transaction","detail":"{read_only:false; response_revision:25593; number_of_response:1; }","duration":"164.522552ms","start":"2026-05-08T11:13:57.525058Z","end":"2026-05-08T11:13:57.689581Z","steps":["trace[564045796] 'process raft request'  (duration: 90.723592ms)","trace[564045796] 'compare'  (duration: 73.641717ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:57.695085Z","caller":"traceutil/trace.go:171","msg":"trace[128872503] transaction","detail":"{read_only:false; response_revision:25594; number_of_response:1; }","duration":"114.526016ms","start":"2026-05-08T11:13:57.58052Z","end":"2026-05-08T11:13:57.695046Z","steps":["trace[128872503] 'process raft request'  (duration: 114.27537ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:58.045011Z","caller":"traceutil/trace.go:171","msg":"trace[1182601892] transaction","detail":"{read_only:false; response_revision:25596; number_of_response:1; }","duration":"344.886752ms","start":"2026-05-08T11:13:57.700074Z","end":"2026-05-08T11:13:58.044961Z","steps":["trace[1182601892] 'process raft request'  (duration: 246.329274ms)","trace[1182601892] 'compare'  (duration: 98.144739ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:58.045048Z","caller":"traceutil/trace.go:171","msg":"trace[1355980236] transaction","detail":"{read_only:false; response_revision:25597; number_of_response:1; }","duration":"344.940914ms","start":"2026-05-08T11:13:57.700076Z","end":"2026-05-08T11:13:58.045017Z","steps":["trace[1355980236] 'process raft request'  (duration: 344.79533ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:58.045201Z","caller":"traceutil/trace.go:171","msg":"trace[921993654] transaction","detail":"{read_only:false; response_revision:25598; number_of_response:1; }","duration":"344.030541ms","start":"2026-05-08T11:13:57.701157Z","end":"2026-05-08T11:13:58.045188Z","steps":["trace[921993654] 'process raft request'  (duration: 343.808906ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:58.045212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:57.70006Z","time spent":"345.039226ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25585 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T11:13:58.045247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:57.70006Z","time spent":"345.080477ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25582 > 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-08T11:13:58.045262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:57.701148Z","time spent":"344.081802ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25583 > 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":"info","ts":"2026-05-08T11:13:58.045577Z","caller":"traceutil/trace.go:171","msg":"trace[650551648] transaction","detail":"{read_only:false; response_revision:25599; number_of_response:1; }","duration":"342.125048ms","start":"2026-05-08T11:13:57.703439Z","end":"2026-05-08T11:13:58.045564Z","steps":["trace[650551648] 'process raft request'  (duration: 341.676456ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:58.045643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:57.703406Z","time spent":"342.20709ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25584 > 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":"info","ts":"2026-05-08T11:13:58.045715Z","caller":"traceutil/trace.go:171","msg":"trace[1800130576] transaction","detail":"{read_only:false; response_revision:25600; number_of_response:1; }","duration":"342.114497ms","start":"2026-05-08T11:13:57.703567Z","end":"2026-05-08T11:13:58.045681Z","steps":["trace[1800130576] 'process raft request'  (duration: 341.936643ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:58.045904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:57.703558Z","time spent":"342.23349ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25581 > 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":"info","ts":"2026-05-08T11:13:59.29288Z","caller":"traceutil/trace.go:171","msg":"trace[2123009762] linearizableReadLoop","detail":"{readStateIndex:26436; appliedIndex:26435; }","duration":"184.652401ms","start":"2026-05-08T11:13:59.108195Z","end":"2026-05-08T11:13:59.292847Z","steps":["trace[2123009762] 'read index received'  (duration: 163.511689ms)","trace[2123009762] 'applied index is now lower than readState.Index'  (duration: 21.139202ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:13:59.292897Z","caller":"traceutil/trace.go:171","msg":"trace[1277119818] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"245.875073ms","start":"2026-05-08T11:13:59.046981Z","end":"2026-05-08T11:13:59.292857Z","steps":["trace[1277119818] 'process raft request'  (duration: 224.71834ms)","trace[1277119818] 'compare'  (duration: 21.009989ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:59.293054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.824094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:13:59.29311Z","caller":"traceutil/trace.go:171","msg":"trace[2082749022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25602; }","duration":"184.957597ms","start":"2026-05-08T11:13:59.108141Z","end":"2026-05-08T11:13:59.293099Z","steps":["trace[2082749022] 'agreement among raft nodes before linearized reading'  (duration: 184.807274ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:13:59.29736Z","caller":"traceutil/trace.go:171","msg":"trace[315130848] transaction","detail":"{read_only:false; response_revision:25603; number_of_response:1; }","duration":"161.199064ms","start":"2026-05-08T11:13:59.1361Z","end":"2026-05-08T11:13:59.297299Z","steps":["trace[315130848] 'process raft request'  (duration: 160.976858ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:59.740517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.259453ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558046441 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25591 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:13:59.740676Z","caller":"traceutil/trace.go:171","msg":"trace[759347633] transaction","detail":"{read_only:false; response_revision:25607; number_of_response:1; }","duration":"338.528521ms","start":"2026-05-08T11:13:59.402127Z","end":"2026-05-08T11:13:59.740656Z","steps":["trace[759347633] 'process raft request'  (duration: 338.48013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:13:59.740729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:59.402081Z","time spent":"338.622623ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25590 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T11:13:59.740785Z","caller":"traceutil/trace.go:171","msg":"trace[1621724597] transaction","detail":"{read_only:false; response_revision:25606; number_of_response:1; }","duration":"338.728625ms","start":"2026-05-08T11:13:59.402014Z","end":"2026-05-08T11:13:59.740743Z","steps":["trace[1621724597] 'process raft request'  (duration: 194.163436ms)","trace[1621724597] 'compare'  (duration: 144.045306ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:13:59.740959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:13:59.401979Z","time spent":"338.882529ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25591 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-08T11:14:00.043397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.491894ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558046446 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25595 > 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-08T11:14:00.043638Z","caller":"traceutil/trace.go:171","msg":"trace[652522829] transaction","detail":"{read_only:false; response_revision:25609; number_of_response:1; }","duration":"254.709572ms","start":"2026-05-08T11:13:59.788882Z","end":"2026-05-08T11:14:00.043591Z","steps":["trace[652522829] 'process raft request'  (duration: 70.907311ms)","trace[652522829] 'compare'  (duration: 183.272219ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:14:00.399506Z","caller":"traceutil/trace.go:171","msg":"trace[1506885594] transaction","detail":"{read_only:false; response_revision:25611; number_of_response:1; }","duration":"345.091027ms","start":"2026-05-08T11:14:00.054368Z","end":"2026-05-08T11:14:00.399459Z","steps":["trace[1506885594] 'process raft request'  (duration: 344.762149ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:00.399509Z","caller":"traceutil/trace.go:171","msg":"trace[1281943471] transaction","detail":"{read_only:false; response_revision:25612; number_of_response:1; }","duration":"345.068426ms","start":"2026-05-08T11:14:00.054404Z","end":"2026-05-08T11:14:00.399472Z","steps":["trace[1281943471] 'process raft request'  (duration: 344.958914ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:00.399728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:14:00.054342Z","time spent":"345.262421ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25596 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T11:14:00.399767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:14:00.054351Z","time spent":"345.268991ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25599 > 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-08T11:14:00.399868Z","caller":"traceutil/trace.go:171","msg":"trace[2053313317] linearizableReadLoop","detail":"{readStateIndex:26448; appliedIndex:26444; }","duration":"162.677059ms","start":"2026-05-08T11:14:00.237168Z","end":"2026-05-08T11:14:00.399845Z","steps":["trace[2053313317] 'read index received'  (duration: 161.988023ms)","trace[2053313317] 'applied index is now lower than readState.Index'  (duration: 687.926µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:14:00.399982Z","caller":"traceutil/trace.go:171","msg":"trace[54534612] transaction","detail":"{read_only:false; response_revision:25614; number_of_response:1; }","duration":"343.718665ms","start":"2026-05-08T11:14:00.05625Z","end":"2026-05-08T11:14:00.399969Z","steps":["trace[54534612] 'process raft request'  (duration: 343.400077ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:00.399988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.808233ms","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-08T11:14:00.400032Z","caller":"traceutil/trace.go:171","msg":"trace[1895931014] 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:25614; }","duration":"162.899535ms","start":"2026-05-08T11:14:00.23712Z","end":"2026-05-08T11:14:00.400019Z","steps":["trace[1895931014] 'agreement among raft nodes before linearized reading'  (duration: 162.810683ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:00.400049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:14:00.056218Z","time spent":"343.796007ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25597 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-08T11:14:00.399956Z","caller":"traceutil/trace.go:171","msg":"trace[582641969] transaction","detail":"{read_only:false; response_revision:25613; number_of_response:1; }","duration":"344.984545ms","start":"2026-05-08T11:14:00.054944Z","end":"2026-05-08T11:14:00.399928Z","steps":["trace[582641969] 'process raft request'  (duration: 344.475533ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:00.400305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:14:00.054927Z","time spent":"345.334833ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25600 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T11:14:01.179119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.76248ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15855096241558046468 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25601 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T11:14:01.179255Z","caller":"traceutil/trace.go:171","msg":"trace[765472991] linearizableReadLoop","detail":"{readStateIndex:26452; appliedIndex:26451; }","duration":"115.615312ms","start":"2026-05-08T11:14:01.063618Z","end":"2026-05-08T11:14:01.179233Z","steps":["trace[765472991] 'read index received'  (duration: 14.648477ms)","trace[765472991] 'applied index is now lower than readState.Index'  (duration: 100.964095ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:14:01.179343Z","caller":"traceutil/trace.go:171","msg":"trace[1039842823] transaction","detail":"{read_only:false; response_revision:25617; number_of_response:1; }","duration":"131.754025ms","start":"2026-05-08T11:14:01.047553Z","end":"2026-05-08T11:14:01.179307Z","steps":["trace[1039842823] 'process raft request'  (duration: 30.666197ms)","trace[1039842823] 'compare'  (duration: 99.942181ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:14:01.179548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.914339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:14:01.179607Z","caller":"traceutil/trace.go:171","msg":"trace[1901403675] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:25617; }","duration":"116.012792ms","start":"2026-05-08T11:14:01.063576Z","end":"2026-05-08T11:14:01.179589Z","steps":["trace[1901403675] 'agreement among raft nodes before linearized reading'  (duration: 115.896009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:01.445327Z","caller":"traceutil/trace.go:171","msg":"trace[1327334023] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"141.841794ms","start":"2026-05-08T11:14:01.303437Z","end":"2026-05-08T11:14:01.445278Z","steps":["trace[1327334023] 'process raft request'  (duration: 141.66713ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:01.778067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.96375ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T11:14:01.778237Z","caller":"traceutil/trace.go:171","msg":"trace[1882321849] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25620; }","duration":"156.158915ms","start":"2026-05-08T11:14:01.622057Z","end":"2026-05-08T11:14:01.778216Z","steps":["trace[1882321849] 'range keys from in-memory index tree'  (duration: 155.9444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:01.77898Z","caller":"traceutil/trace.go:171","msg":"trace[1907169964] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"176.551768ms","start":"2026-05-08T11:14:01.60231Z","end":"2026-05-08T11:14:01.778862Z","steps":["trace[1907169964] 'process raft request'  (duration: 127.953585ms)","trace[1907169964] 'compare'  (duration: 47.412175ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:14:02.275232Z","caller":"traceutil/trace.go:171","msg":"trace[1348268980] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"112.352776ms","start":"2026-05-08T11:14:02.162837Z","end":"2026-05-08T11:14:02.275189Z","steps":["trace[1348268980] 'process raft request'  (duration: 80.211484ms)","trace[1348268980] 'compare'  (duration: 31.886266ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:14:07.573913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22244}
{"level":"info","ts":"2026-05-08T11:14:07.691097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22244,"took":"111.926196ms","hash":1876410390,"current-db-size-bytes":57794560,"current-db-size":"58 MB","current-db-size-in-use-bytes":43307008,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-05-08T11:14:07.691247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1876410390,"revision":22244,"compact-revision":20066}
{"level":"info","ts":"2026-05-08T11:14:18.37821Z","caller":"traceutil/trace.go:171","msg":"trace[1638812013] transaction","detail":"{read_only:false; response_revision:25753; number_of_response:1; }","duration":"127.909405ms","start":"2026-05-08T11:14:18.250261Z","end":"2026-05-08T11:14:18.37817Z","steps":["trace[1638812013] 'process raft request'  (duration: 127.67444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:23.564453Z","caller":"traceutil/trace.go:171","msg":"trace[223572392] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"104.389336ms","start":"2026-05-08T11:14:23.460024Z","end":"2026-05-08T11:14:23.564413Z","steps":["trace[223572392] 'process raft request'  (duration: 104.190131ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:23.899686Z","caller":"traceutil/trace.go:171","msg":"trace[1778545146] transaction","detail":"{read_only:false; response_revision:25793; number_of_response:1; }","duration":"347.73936ms","start":"2026-05-08T11:14:23.551921Z","end":"2026-05-08T11:14:23.899661Z","steps":["trace[1778545146] 'process raft request'  (duration: 347.575756ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:23.899906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:14:23.551888Z","time spent":"347.899814ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25779 > 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-08T11:14:24.04725Z","caller":"traceutil/trace.go:171","msg":"trace[2135823062] transaction","detail":"{read_only:false; response_revision:25795; number_of_response:1; }","duration":"158.117011ms","start":"2026-05-08T11:14:23.889098Z","end":"2026-05-08T11:14:24.047215Z","steps":["trace[2135823062] 'process raft request'  (duration: 158.018469ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:24.047566Z","caller":"traceutil/trace.go:171","msg":"trace[436551358] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"382.038853ms","start":"2026-05-08T11:14:23.665512Z","end":"2026-05-08T11:14:24.047551Z","steps":["trace[436551358] 'process raft request'  (duration: 355.037843ms)","trace[436551358] 'compare'  (duration: 26.376105ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T11:14:24.047734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T11:14:23.665485Z","time spent":"382.146686ms","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25780 > 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-08T11:14:24.047797Z","caller":"traceutil/trace.go:171","msg":"trace[1602821092] transaction","detail":"{read_only:false; response_revision:25796; number_of_response:1; }","duration":"152.447487ms","start":"2026-05-08T11:14:23.895328Z","end":"2026-05-08T11:14:24.047775Z","steps":["trace[1602821092] 'process raft request'  (duration: 151.842502ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:24.048017Z","caller":"traceutil/trace.go:171","msg":"trace[747409497] linearizableReadLoop","detail":"{readStateIndex:26634; appliedIndex:26632; }","duration":"185.885651ms","start":"2026-05-08T11:14:23.862098Z","end":"2026-05-08T11:14:24.047984Z","steps":["trace[747409497] 'read index received'  (duration: 37.49428ms)","trace[747409497] 'applied index is now lower than readState.Index'  (duration: 148.390201ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T11:14:24.048097Z","caller":"traceutil/trace.go:171","msg":"trace[513371658] transaction","detail":"{read_only:false; response_revision:25797; number_of_response:1; }","duration":"150.372628ms","start":"2026-05-08T11:14:23.897649Z","end":"2026-05-08T11:14:24.048022Z","steps":["trace[513371658] 'process raft request'  (duration: 150.237935ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:24.048192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.067365ms","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-08T11:14:24.048241Z","caller":"traceutil/trace.go:171","msg":"trace[1200854099] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:25797; }","duration":"186.192068ms","start":"2026-05-08T11:14:23.862033Z","end":"2026-05-08T11:14:24.048225Z","steps":["trace[1200854099] 'agreement among raft nodes before linearized reading'  (duration: 186.064225ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:14:29.405922Z","caller":"traceutil/trace.go:171","msg":"trace[1164776380] transaction","detail":"{read_only:false; response_revision:25832; number_of_response:1; }","duration":"112.015428ms","start":"2026-05-08T11:14:29.293858Z","end":"2026-05-08T11:14:29.405873Z","steps":["trace[1164776380] 'process raft request'  (duration: 111.416744ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T11:14:29.672348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.066794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-08T11:14:29.672443Z","caller":"traceutil/trace.go:171","msg":"trace[672150298] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25832; }","duration":"159.368291ms","start":"2026-05-08T11:14:29.513054Z","end":"2026-05-08T11:14:29.672423Z","steps":["trace[672150298] 'range keys from in-memory index tree'  (duration: 157.969359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T11:15:34.97Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b15.wal"}
{"level":"info","ts":"2026-05-08T11:19:07.580688Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25664}
{"level":"info","ts":"2026-05-08T11:19:07.739842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25664,"took":"153.991841ms","hash":1216667763,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":35250176,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-08T11:19:07.739936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1216667763,"revision":25664,"compact-revision":22244}
{"level":"info","ts":"2026-05-08T11:20:15.342154Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d1606b245347dc08","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T11:20:15.3477Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-08T11:20:15.347843Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-08T11:24:07.587946Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28548}
{"level":"info","ts":"2026-05-08T11:24:07.731352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28548,"took":"137.974456ms","hash":2258447644,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":30568448,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-08T11:24:07.731434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2258447644,"revision":28548,"compact-revision":25664}
{"level":"info","ts":"2026-05-08T11:29:07.594115Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30764}
{"level":"info","ts":"2026-05-08T11:29:07.709663Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30764,"took":"109.827045ms","hash":2408836130,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":30949376,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-08T11:29:07.709724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2408836130,"revision":30764,"compact-revision":28548}
{"level":"info","ts":"2026-05-08T11:34:07.601496Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33028}
{"level":"info","ts":"2026-05-08T11:34:07.762937Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33028,"took":"155.542311ms","hash":1871122181,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":31072256,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-08T11:34:07.763041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1871122181,"revision":33028,"compact-revision":30764}
{"level":"info","ts":"2026-05-08T11:39:07.609716Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35325}
{"level":"info","ts":"2026-05-08T11:39:07.755146Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35325,"took":"140.900449ms","hash":4005221149,"current-db-size-bytes":59531264,"current-db-size":"60 MB","current-db-size-in-use-bytes":31801344,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-08T11:39:07.75522Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4005221149,"revision":35325,"compact-revision":33028}
{"level":"info","ts":"2026-05-08T11:41:46.275795Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d1606b245347dc08","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T11:41:46.28112Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-08T11:41:46.281262Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-08T11:44:07.640463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37549}
{"level":"info","ts":"2026-05-08T11:44:08.012095Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37549,"took":"366.298979ms","hash":1141173197,"current-db-size-bytes":59531264,"current-db-size":"60 MB","current-db-size-in-use-bytes":31342592,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-08T11:44:08.012173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1141173197,"revision":37549,"compact-revision":35325}