{"level":"warn","ts":"2026-05-25T13:57:13.317455Z","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-25T13:57:13.317564Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-25T13:57:13.317642Z","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-25T13:57:13.317659Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-25T13:57:13.317684Z","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-25T13:57:13.318518Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]}
{"level":"info","ts":"2026-05-25T13:57:13.318617Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-25T13:57:13.32297Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.111277ms"}
{"level":"info","ts":"2026-05-25T13:57:13.332125Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"}
{"level":"info","ts":"2026-05-25T13:57:13.332211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-25T13:57:13.332237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"}
{"level":"info","ts":"2026-05-25T13:57:13.332252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-25T13:57:13.332265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"}
{"level":"info","ts":"2026-05-25T13:57:13.332313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"warn","ts":"2026-05-25T13:57:13.338223Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-25T13:57:13.339528Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-25T13:57:13.340867Z","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-25T13:57:13.343094Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-25T13:57:13.343344Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-25T13:57:13.343444Z","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-25T13:57:13.343601Z","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-25T13:57:13.343641Z","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-25T13:57:13.345793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"info","ts":"2026-05-25T13:57:13.345978Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-25T13:57:13.349233Z","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-25T13:57:13.349631Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-25T13:57:13.349739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-25T13:57:13.349892Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-25T13:57:13.349944Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-25T13:57:13.935631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-25T13:57:13.935676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-25T13:57:13.935699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"}
{"level":"info","ts":"2026-05-25T13:57:13.935711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"}
{"level":"info","ts":"2026-05-25T13:57:13.935719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-25T13:57:13.935726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"}
{"level":"info","ts":"2026-05-25T13:57:13.935733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-25T13:57:13.940475Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T13:57:13.942782Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-25T13:57:13.942788Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-25T13:57:13.942846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-25T13:57:13.943218Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-25T13:57:13.943325Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-25T13:57:13.943382Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T13:57:13.943522Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T13:57:13.943859Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T13:57:13.945088Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"}
{"level":"info","ts":"2026-05-25T13:57:13.946255Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-25T13:57:33.185612Z","caller":"traceutil/trace.go:171","msg":"trace[1662364511] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"103.389425ms","start":"2026-05-25T13:57:33.082184Z","end":"2026-05-25T13:57:33.185574Z","steps":["trace[1662364511] 'process raft request'  (duration: 103.131049ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T13:57:56.921754Z","caller":"traceutil/trace.go:171","msg":"trace[1283681878] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"268.563349ms","start":"2026-05-25T13:57:56.653144Z","end":"2026-05-25T13:57:56.921707Z","steps":["trace[1283681878] 'process raft request'  (duration: 267.993276ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T13:57:57.362991Z","caller":"traceutil/trace.go:171","msg":"trace[601283016] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"369.543821ms","start":"2026-05-25T13:57:56.993399Z","end":"2026-05-25T13:57:57.362943Z","steps":["trace[601283016] 'read index received'  (duration: 270.420479ms)","trace[601283016] 'applied index is now lower than readState.Index'  (duration: 99.121692ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T13:57:57.363267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.987688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-25T13:57:57.363428Z","caller":"traceutil/trace.go:171","msg":"trace[2135767479] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:623; }","duration":"355.159261ms","start":"2026-05-25T13:57:57.008245Z","end":"2026-05-25T13:57:57.363405Z","steps":["trace[2135767479] 'agreement among raft nodes before linearized reading'  (duration: 354.920086ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T13:57:57.363476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T13:57:57.008178Z","time spent":"355.285714ms","remote":"127.0.0.1:49618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.89\" "}
{"level":"warn","ts":"2026-05-25T13:57:57.363247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.818826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T13:57:57.363712Z","caller":"traceutil/trace.go:171","msg":"trace[52443790] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:623; }","duration":"370.306156ms","start":"2026-05-25T13:57:56.993338Z","end":"2026-05-25T13:57:57.363644Z","steps":["trace[52443790] 'agreement among raft nodes before linearized reading'  (duration: 369.801296ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T13:57:57.363865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T13:57:56.993315Z","time spent":"370.49576ms","remote":"127.0.0.1:49788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"info","ts":"2026-05-25T13:57:57.366373Z","caller":"traceutil/trace.go:171","msg":"trace[620642319] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"428.048057ms","start":"2026-05-25T13:57:56.935618Z","end":"2026-05-25T13:57:57.363666Z","steps":["trace[620642319] 'process raft request'  (duration: 328.334812ms)","trace[620642319] 'compare'  (duration: 98.718094ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T13:57:57.369107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T13:57:56.935573Z","time spent":"431.710124ms","remote":"127.0.0.1:49772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-xr7ld\" mod_revision:521 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-xr7ld\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-xr7ld\" > >"}
{"level":"warn","ts":"2026-05-25T13:59:28.073433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.95516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T13:59:28.073532Z","caller":"traceutil/trace.go:171","msg":"trace[1660369896] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1872; }","duration":"139.126773ms","start":"2026-05-25T13:59:27.934384Z","end":"2026-05-25T13:59:28.073511Z","steps":["trace[1660369896] 'count revisions from in-memory index tree'  (duration: 138.790787ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T13:59:28.073829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.906364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-25T13:59:28.073939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.318594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-25T13:59:28.074046Z","caller":"traceutil/trace.go:171","msg":"trace[699091305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1872; }","duration":"184.466577ms","start":"2026-05-25T13:59:27.889558Z","end":"2026-05-25T13:59:28.074025Z","steps":["trace[699091305] 'range keys from in-memory index tree'  (duration: 183.573259ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T13:59:28.073976Z","caller":"traceutil/trace.go:171","msg":"trace[1025508506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1872; }","duration":"183.136429ms","start":"2026-05-25T13:59:27.890808Z","end":"2026-05-25T13:59:28.073944Z","steps":["trace[1025508506] 'range keys from in-memory index tree'  (duration: 182.390653ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T13:59:28.155119Z","caller":"traceutil/trace.go:171","msg":"trace[46551516] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"133.481038ms","start":"2026-05-25T13:59:28.021525Z","end":"2026-05-25T13:59:28.155006Z","steps":["trace[46551516] 'process raft request'  (duration: 133.284514ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T13:59:28.431768Z","caller":"traceutil/trace.go:171","msg":"trace[318091485] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"109.962433ms","start":"2026-05-25T13:59:28.32177Z","end":"2026-05-25T13:59:28.431733Z","steps":["trace[318091485] 'process raft request'  (duration: 109.769879ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:00:19.572191Z","caller":"traceutil/trace.go:171","msg":"trace[417450573] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"121.970039ms","start":"2026-05-25T14:00:19.450188Z","end":"2026-05-25T14:00:19.572158Z","steps":["trace[417450573] 'process raft request'  (duration: 121.793786ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:00:19.960795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.638572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-25T14:00:19.960931Z","caller":"traceutil/trace.go:171","msg":"trace[263760386] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2203; }","duration":"170.831456ms","start":"2026-05-25T14:00:19.790062Z","end":"2026-05-25T14:00:19.960893Z","steps":["trace[263760386] 'range keys from in-memory index tree'  (duration: 170.288905ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:01:49.876011Z","caller":"traceutil/trace.go:171","msg":"trace[837408781] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"130.69746ms","start":"2026-05-25T14:01:49.745286Z","end":"2026-05-25T14:01:49.875984Z","steps":["trace[837408781] 'process raft request'  (duration: 130.525936ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:04:25.960371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.936083ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170127970 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:3894 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-25T14:04:25.960684Z","caller":"traceutil/trace.go:171","msg":"trace[576600733] transaction","detail":"{read_only:false; response_revision:3905; number_of_response:1; }","duration":"259.79574ms","start":"2026-05-25T14:04:25.700841Z","end":"2026-05-25T14:04:25.960636Z","steps":["trace[576600733] 'process raft request'  (duration: 259.635587ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:04:25.960748Z","caller":"traceutil/trace.go:171","msg":"trace[300283760] transaction","detail":"{read_only:false; response_revision:3904; number_of_response:1; }","duration":"261.30797ms","start":"2026-05-25T14:04:25.699323Z","end":"2026-05-25T14:04:25.960631Z","steps":["trace[300283760] 'process raft request'  (duration: 123.906838ms)","trace[300283760] 'compare'  (duration: 136.584447ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:05:55.046966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.300095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1c8d63a7-16c8-4984-9473-333a3f946fda\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-05-25T14:05:55.047082Z","caller":"traceutil/trace.go:171","msg":"trace[1755986325] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1c8d63a7-16c8-4984-9473-333a3f946fda; range_end:; response_count:1; response_revision:5100; }","duration":"120.480409ms","start":"2026-05-25T14:05:54.926577Z","end":"2026-05-25T14:05:55.047057Z","steps":["trace[1755986325] 'range keys from in-memory index tree'  (duration: 120.053391ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:05:55.047248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.225382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T14:05:55.047383Z","caller":"traceutil/trace.go:171","msg":"trace[797859202] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5100; }","duration":"133.440896ms","start":"2026-05-25T14:05:54.913914Z","end":"2026-05-25T14:05:55.047355Z","steps":["trace[797859202] 'range keys from in-memory index tree'  (duration: 133.057979ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:05:55.352017Z","caller":"traceutil/trace.go:171","msg":"trace[500679708] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"129.507968ms","start":"2026-05-25T14:05:55.222456Z","end":"2026-05-25T14:05:55.351964Z","steps":["trace[500679708] 'process raft request'  (duration: 105.249366ms)","trace[500679708] 'compare'  (duration: 23.821714ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:05:55.352136Z","caller":"traceutil/trace.go:171","msg":"trace[1307984692] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"129.61717ms","start":"2026-05-25T14:05:55.222488Z","end":"2026-05-25T14:05:55.352105Z","steps":["trace[1307984692] 'process raft request'  (duration: 129.377575ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:06:09.19291Z","caller":"traceutil/trace.go:171","msg":"trace[249729514] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"273.19611ms","start":"2026-05-25T14:06:08.919676Z","end":"2026-05-25T14:06:09.192872Z","steps":["trace[249729514] 'process raft request'  (duration: 229.347436ms)","trace[249729514] 'compare'  (duration: 43.393415ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:06:09.451272Z","caller":"traceutil/trace.go:171","msg":"trace[316235526] linearizableReadLoop","detail":"{readStateIndex:5584; appliedIndex:5583; }","duration":"140.648509ms","start":"2026-05-25T14:06:09.3106Z","end":"2026-05-25T14:06:09.451248Z","steps":["trace[316235526] 'read index received'  (duration: 136.600779ms)","trace[316235526] 'applied index is now lower than readState.Index'  (duration: 4.04592ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:06:09.45132Z","caller":"traceutil/trace.go:171","msg":"trace[1415832257] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"157.696459ms","start":"2026-05-25T14:06:09.293579Z","end":"2026-05-25T14:06:09.451276Z","steps":["trace[1415832257] 'process raft request'  (duration: 153.599938ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:06:09.451415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.801483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T14:06:09.451521Z","caller":"traceutil/trace.go:171","msg":"trace[1809138628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5384; }","duration":"140.956835ms","start":"2026-05-25T14:06:09.310545Z","end":"2026-05-25T14:06:09.451502Z","steps":["trace[1809138628] 'agreement among raft nodes before linearized reading'  (duration: 140.759021ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:06:16.56469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.644567ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170131667 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:5325 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-25T14:06:16.56499Z","caller":"traceutil/trace.go:171","msg":"trace[1486838731] transaction","detail":"{read_only:false; response_revision:5558; number_of_response:1; }","duration":"192.268779ms","start":"2026-05-25T14:06:16.372673Z","end":"2026-05-25T14:06:16.564942Z","steps":["trace[1486838731] 'process raft request'  (duration: 27.253453ms)","trace[1486838731] 'compare'  (duration: 164.473134ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:06:16.565085Z","caller":"traceutil/trace.go:171","msg":"trace[1021681591] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"187.239748ms","start":"2026-05-25T14:06:16.377808Z","end":"2026-05-25T14:06:16.565048Z","steps":["trace[1021681591] 'process raft request'  (duration: 187.028384ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:06:16.755072Z","caller":"traceutil/trace.go:171","msg":"trace[1490061766] transaction","detail":"{read_only:false; response_revision:5560; number_of_response:1; }","duration":"104.531401ms","start":"2026-05-25T14:06:16.650501Z","end":"2026-05-25T14:06:16.755032Z","steps":["trace[1490061766] 'process raft request'  (duration: 25.824344ms)","trace[1490061766] 'compare'  (duration: 78.451562ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:06:16.755088Z","caller":"traceutil/trace.go:171","msg":"trace[610968872] transaction","detail":"{read_only:false; response_revision:5561; number_of_response:1; }","duration":"102.989229ms","start":"2026-05-25T14:06:16.652066Z","end":"2026-05-25T14:06:16.755055Z","steps":["trace[610968872] 'process raft request'  (duration: 102.883027ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:06:16.755409Z","caller":"traceutil/trace.go:171","msg":"trace[753220102] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"103.124013ms","start":"2026-05-25T14:06:16.652203Z","end":"2026-05-25T14:06:16.755327Z","steps":["trace[753220102] 'process raft request'  (duration: 102.808436ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:07:13.976086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3016}
{"level":"info","ts":"2026-05-25T14:07:14.0697Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3016,"took":"91.492122ms","hash":529290351,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":31756288,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-25T14:07:14.069784Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":529290351,"revision":3016,"compact-revision":-1}
{"level":"info","ts":"2026-05-25T14:12:13.982347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6084}
{"level":"info","ts":"2026-05-25T14:12:14.082094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6084,"took":"97.551566ms","hash":562970236,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":21954560,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-25T14:12:14.082174Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":562970236,"revision":6084,"compact-revision":3016}
{"level":"info","ts":"2026-05-25T14:12:25.179711Z","caller":"traceutil/trace.go:171","msg":"trace[2044366203] linearizableReadLoop","detail":"{readStateIndex:8666; appliedIndex:8665; }","duration":"173.434099ms","start":"2026-05-25T14:12:25.006242Z","end":"2026-05-25T14:12:25.179676Z","steps":["trace[2044366203] 'read index received'  (duration: 173.02755ms)","trace[2044366203] 'applied index is now lower than readState.Index'  (duration: 405.439µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:12:25.179801Z","caller":"traceutil/trace.go:171","msg":"trace[262005965] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"182.645794ms","start":"2026-05-25T14:12:24.997095Z","end":"2026-05-25T14:12:25.179741Z","steps":["trace[262005965] 'process raft request'  (duration: 182.309716ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:12:25.179987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.720094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-25T14:12:25.180023Z","caller":"traceutil/trace.go:171","msg":"trace[1622713744] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8372; }","duration":"173.835356ms","start":"2026-05-25T14:12:25.006179Z","end":"2026-05-25T14:12:25.180015Z","steps":["trace[1622713744] 'agreement among raft nodes before linearized reading'  (duration: 173.642593ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:12:25.37431Z","caller":"traceutil/trace.go:171","msg":"trace[1454755394] transaction","detail":"{read_only:false; response_revision:8373; number_of_response:1; }","duration":"137.298013ms","start":"2026-05-25T14:12:25.236977Z","end":"2026-05-25T14:12:25.374275Z","steps":["trace[1454755394] 'process raft request'  (duration: 137.032908ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:12:36.565411Z","caller":"traceutil/trace.go:171","msg":"trace[1209359013] linearizableReadLoop","detail":"{readStateIndex:8726; appliedIndex:8725; }","duration":"111.026017ms","start":"2026-05-25T14:12:36.454358Z","end":"2026-05-25T14:12:36.565384Z","steps":["trace[1209359013] 'read index received'  (duration: 110.724611ms)","trace[1209359013] 'applied index is now lower than readState.Index'  (duration: 299.786µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:12:36.565546Z","caller":"traceutil/trace.go:171","msg":"trace[962898606] transaction","detail":"{read_only:false; response_revision:8429; number_of_response:1; }","duration":"136.986067ms","start":"2026-05-25T14:12:36.428531Z","end":"2026-05-25T14:12:36.565517Z","steps":["trace[962898606] 'process raft request'  (duration: 136.63706ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:12:36.565783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.367143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-25T14:12:36.565928Z","caller":"traceutil/trace.go:171","msg":"trace[72950142] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:8429; }","duration":"111.583798ms","start":"2026-05-25T14:12:36.454312Z","end":"2026-05-25T14:12:36.565896Z","steps":["trace[72950142] 'agreement among raft nodes before linearized reading'  (duration: 111.226631ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:12:37.477998Z","caller":"traceutil/trace.go:171","msg":"trace[904271018] transaction","detail":"{read_only:false; response_revision:8435; number_of_response:1; }","duration":"257.156597ms","start":"2026-05-25T14:12:37.220799Z","end":"2026-05-25T14:12:37.477955Z","steps":["trace[904271018] 'process raft request'  (duration: 256.548484ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:12:37.4876Z","caller":"traceutil/trace.go:171","msg":"trace[1686745097] linearizableReadLoop","detail":"{readStateIndex:8734; appliedIndex:8732; }","duration":"176.620472ms","start":"2026-05-25T14:12:37.310924Z","end":"2026-05-25T14:12:37.487545Z","steps":["trace[1686745097] 'read index received'  (duration: 166.793635ms)","trace[1686745097] 'applied index is now lower than readState.Index'  (duration: 9.825287ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:12:37.487622Z","caller":"traceutil/trace.go:171","msg":"trace[425880100] transaction","detail":"{read_only:false; response_revision:8436; number_of_response:1; }","duration":"184.223484ms","start":"2026-05-25T14:12:37.303334Z","end":"2026-05-25T14:12:37.487558Z","steps":["trace[425880100] 'process raft request'  (duration: 183.948379ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:12:37.487862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.892287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T14:12:37.487936Z","caller":"traceutil/trace.go:171","msg":"trace[1189223002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8438; }","duration":"177.06571ms","start":"2026-05-25T14:12:37.310858Z","end":"2026-05-25T14:12:37.487923Z","steps":["trace[1189223002] 'agreement among raft nodes before linearized reading'  (duration: 176.829976ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:13:06.093302Z","caller":"traceutil/trace.go:171","msg":"trace[1076611231] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"108.710989ms","start":"2026-05-25T14:13:05.984561Z","end":"2026-05-25T14:13:06.093272Z","steps":["trace[1076611231] 'process raft request'  (duration: 108.190379ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:13:06.289317Z","caller":"traceutil/trace.go:171","msg":"trace[516693129] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"186.264925ms","start":"2026-05-25T14:13:06.102999Z","end":"2026-05-25T14:13:06.289264Z","steps":["trace[516693129] 'process raft request'  (duration: 186.161632ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:13:06.289851Z","caller":"traceutil/trace.go:171","msg":"trace[1991387253] linearizableReadLoop","detail":"{readStateIndex:8952; appliedIndex:8950; }","duration":"117.427945ms","start":"2026-05-25T14:13:06.1724Z","end":"2026-05-25T14:13:06.289828Z","steps":["trace[1991387253] 'read index received'  (duration: 116.095077ms)","trace[1991387253] 'applied index is now lower than readState.Index'  (duration: 1.330048ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:13:06.289986Z","caller":"traceutil/trace.go:171","msg":"trace[1071205242] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"187.903348ms","start":"2026-05-25T14:13:06.102071Z","end":"2026-05-25T14:13:06.289974Z","steps":["trace[1071205242] 'process raft request'  (duration: 186.293035ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:13:06.290307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.879313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-25T14:13:06.290464Z","caller":"traceutil/trace.go:171","msg":"trace[539905411] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8647; }","duration":"118.026917ms","start":"2026-05-25T14:13:06.172358Z","end":"2026-05-25T14:13:06.290385Z","steps":["trace[539905411] 'agreement among raft nodes before linearized reading'  (duration: 117.779582ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:13:06.290668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.542846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T14:13:06.290735Z","caller":"traceutil/trace.go:171","msg":"trace[493307298] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:8647; }","duration":"101.611067ms","start":"2026-05-25T14:13:06.189089Z","end":"2026-05-25T14:13:06.2907Z","steps":["trace[493307298] 'agreement among raft nodes before linearized reading'  (duration: 101.515615ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:13:14.681825Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000233f.wal"}
{"level":"info","ts":"2026-05-25T14:13:19.333283Z","caller":"traceutil/trace.go:171","msg":"trace[2019330519] transaction","detail":"{read_only:false; response_revision:8759; number_of_response:1; }","duration":"149.284564ms","start":"2026-05-25T14:13:19.183969Z","end":"2026-05-25T14:13:19.333253Z","steps":["trace[2019330519] 'process raft request'  (duration: 101.589387ms)","trace[2019330519] 'compare'  (duration: 47.497863ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:13:19.821525Z","caller":"traceutil/trace.go:171","msg":"trace[1241546633] transaction","detail":"{read_only:false; response_revision:8764; number_of_response:1; }","duration":"157.858476ms","start":"2026-05-25T14:13:19.66364Z","end":"2026-05-25T14:13:19.821498Z","steps":["trace[1241546633] 'process raft request'  (duration: 157.781514ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:13:19.821934Z","caller":"traceutil/trace.go:171","msg":"trace[1920253701] transaction","detail":"{read_only:false; response_revision:8763; number_of_response:1; }","duration":"159.654372ms","start":"2026-05-25T14:13:19.662267Z","end":"2026-05-25T14:13:19.821922Z","steps":["trace[1920253701] 'process raft request'  (duration: 152.986439ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:13:20.131153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.47822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"info","ts":"2026-05-25T14:13:20.131255Z","caller":"traceutil/trace.go:171","msg":"trace[1689199806] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8764; }","duration":"203.669214ms","start":"2026-05-25T14:13:19.927566Z","end":"2026-05-25T14:13:20.131235Z","steps":["trace[1689199806] 'range keys from in-memory index tree'  (duration: 203.246714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:14:37.456412Z","caller":"traceutil/trace.go:171","msg":"trace[520901977] linearizableReadLoop","detail":"{readStateIndex:9850; appliedIndex:9849; }","duration":"144.56246ms","start":"2026-05-25T14:14:37.311818Z","end":"2026-05-25T14:14:37.456381Z","steps":["trace[520901977] 'read index received'  (duration: 144.273405ms)","trace[520901977] 'applied index is now lower than readState.Index'  (duration: 288.315µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:14:37.456549Z","caller":"traceutil/trace.go:171","msg":"trace[77479090] transaction","detail":"{read_only:false; response_revision:9517; number_of_response:1; }","duration":"200.906002ms","start":"2026-05-25T14:14:37.255633Z","end":"2026-05-25T14:14:37.456539Z","steps":["trace[77479090] 'process raft request'  (duration: 200.532784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:14:37.45684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.99503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T14:14:37.456909Z","caller":"traceutil/trace.go:171","msg":"trace[639969429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9517; }","duration":"145.121712ms","start":"2026-05-25T14:14:37.31177Z","end":"2026-05-25T14:14:37.456892Z","steps":["trace[639969429] 'agreement among raft nodes before linearized reading'  (duration: 144.988629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:14:55.573929Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T14:14:55.612862Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-25T14:14:55.613041Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-25T14:17:13.996044Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8175}
{"level":"info","ts":"2026-05-25T14:17:14.062699Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8175,"took":"63.694472ms","hash":785211513,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":28438528,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-25T14:17:14.062816Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":785211513,"revision":8175,"compact-revision":6084}
{"level":"info","ts":"2026-05-25T14:22:14.002543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10541}
{"level":"info","ts":"2026-05-25T14:22:14.07811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10541,"took":"73.036162ms","hash":1282029342,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":26419200,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-25T14:22:14.078163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1282029342,"revision":10541,"compact-revision":8175}
{"level":"info","ts":"2026-05-25T14:26:39.936304Z","caller":"traceutil/trace.go:171","msg":"trace[257596742] transaction","detail":"{read_only:false; response_revision:14520; number_of_response:1; }","duration":"183.615659ms","start":"2026-05-25T14:26:39.752651Z","end":"2026-05-25T14:26:39.936267Z","steps":["trace[257596742] 'process raft request'  (duration: 183.418195ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:26:39.937242Z","caller":"traceutil/trace.go:171","msg":"trace[656871254] transaction","detail":"{read_only:false; response_revision:14522; number_of_response:1; }","duration":"183.385963ms","start":"2026-05-25T14:26:39.753842Z","end":"2026-05-25T14:26:39.937228Z","steps":["trace[656871254] 'process raft request'  (duration: 183.352273ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:26:39.937329Z","caller":"traceutil/trace.go:171","msg":"trace[378147267] transaction","detail":"{read_only:false; response_revision:14521; number_of_response:1; }","duration":"184.022116ms","start":"2026-05-25T14:26:39.753274Z","end":"2026-05-25T14:26:39.937296Z","steps":["trace[378147267] 'process raft request'  (duration: 183.850312ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:26:53.740209Z","caller":"traceutil/trace.go:171","msg":"trace[457010815] linearizableReadLoop","detail":"{readStateIndex:15095; appliedIndex:15094; }","duration":"118.441177ms","start":"2026-05-25T14:26:53.621741Z","end":"2026-05-25T14:26:53.740182Z","steps":["trace[457010815] 'read index received'  (duration: 118.180971ms)","trace[457010815] 'applied index is now lower than readState.Index'  (duration: 259.106µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:26:53.740644Z","caller":"traceutil/trace.go:171","msg":"trace[107146371] transaction","detail":"{read_only:false; response_revision:14590; number_of_response:1; }","duration":"324.917721ms","start":"2026-05-25T14:26:53.415709Z","end":"2026-05-25T14:26:53.740627Z","steps":["trace[107146371] 'process raft request'  (duration: 324.316559ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:26:53.740805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:26:53.415677Z","time spent":"325.027434ms","remote":"127.0.0.1:49846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:14579 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-25T14:26:53.741047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.318605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-25T14:26:53.741075Z","caller":"traceutil/trace.go:171","msg":"trace[1466976729] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14590; }","duration":"119.396816ms","start":"2026-05-25T14:26:53.621669Z","end":"2026-05-25T14:26:53.741066Z","steps":["trace[1466976729] 'agreement among raft nodes before linearized reading'  (duration: 119.269724ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:27:14.008738Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12734}
{"level":"info","ts":"2026-05-25T14:27:14.091828Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12734,"took":"78.744503ms","hash":3324458040,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":28426240,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-25T14:27:14.091911Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3324458040,"revision":12734,"compact-revision":10541}
{"level":"warn","ts":"2026-05-25T14:27:18.856985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.105288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-adf7ebbf-22c1-4120-b413-ba54db08c375\" ","response":"range_response_count:1 size:3636"}
{"level":"info","ts":"2026-05-25T14:27:18.857123Z","caller":"traceutil/trace.go:171","msg":"trace[707803946] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-adf7ebbf-22c1-4120-b413-ba54db08c375; range_end:; response_count:1; response_revision:14929; }","duration":"188.364453ms","start":"2026-05-25T14:27:18.66873Z","end":"2026-05-25T14:27:18.857095Z","steps":["trace[707803946] 'range keys from in-memory index tree'  (duration: 187.782032ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:27:19.020007Z","caller":"traceutil/trace.go:171","msg":"trace[1733217202] transaction","detail":"{read_only:false; response_revision:14930; number_of_response:1; }","duration":"154.888805ms","start":"2026-05-25T14:27:18.865086Z","end":"2026-05-25T14:27:19.019975Z","steps":["trace[1733217202] 'process raft request'  (duration: 154.708572ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:28:34.530284Z","caller":"traceutil/trace.go:171","msg":"trace[284248490] transaction","detail":"{read_only:false; response_revision:15685; number_of_response:1; }","duration":"141.200031ms","start":"2026-05-25T14:28:34.389027Z","end":"2026-05-25T14:28:34.530227Z","steps":["trace[284248490] 'process raft request'  (duration: 140.910775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:28:34.678223Z","caller":"traceutil/trace.go:171","msg":"trace[52277448] linearizableReadLoop","detail":"{readStateIndex:16227; appliedIndex:16226; }","duration":"116.402045ms","start":"2026-05-25T14:28:34.561788Z","end":"2026-05-25T14:28:34.67819Z","steps":["trace[52277448] 'read index received'  (duration: 107.698881ms)","trace[52277448] 'applied index is now lower than readState.Index'  (duration: 8.701554ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:28:34.678317Z","caller":"traceutil/trace.go:171","msg":"trace[771644348] transaction","detail":"{read_only:false; response_revision:15686; number_of_response:1; }","duration":"140.446816ms","start":"2026-05-25T14:28:34.537826Z","end":"2026-05-25T14:28:34.678272Z","steps":["trace[771644348] 'process raft request'  (duration: 131.62558ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:34.678552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.64652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-25T14:28:34.678617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.65614ms","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-25T14:28:34.678636Z","caller":"traceutil/trace.go:171","msg":"trace[1116503580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15686; }","duration":"116.754632ms","start":"2026-05-25T14:28:34.56186Z","end":"2026-05-25T14:28:34.678614Z","steps":["trace[1116503580] 'agreement among raft nodes before linearized reading'  (duration: 116.538487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:28:34.678687Z","caller":"traceutil/trace.go:171","msg":"trace[1723906841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15686; }","duration":"116.797193ms","start":"2026-05-25T14:28:34.561869Z","end":"2026-05-25T14:28:34.678667Z","steps":["trace[1723906841] 'agreement among raft nodes before linearized reading'  (duration: 116.561768ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:34.678836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.033838ms","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-25T14:28:34.679075Z","caller":"traceutil/trace.go:171","msg":"trace[1334802321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15686; }","duration":"117.287393ms","start":"2026-05-25T14:28:34.561766Z","end":"2026-05-25T14:28:34.679054Z","steps":["trace[1334802321] 'agreement among raft nodes before linearized reading'  (duration: 116.589919ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.724109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.390654ms","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-25T14:28:35.724188Z","caller":"traceutil/trace.go:171","msg":"trace[1242819689] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15692; }","duration":"200.507296ms","start":"2026-05-25T14:28:35.523662Z","end":"2026-05-25T14:28:35.724169Z","steps":["trace[1242819689] 'range keys from in-memory index tree'  (duration: 200.304413ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.724399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.142169ms","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-25T14:28:35.724455Z","caller":"traceutil/trace.go:171","msg":"trace[724302422] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15692; }","duration":"200.251901ms","start":"2026-05-25T14:28:35.52419Z","end":"2026-05-25T14:28:35.724442Z","steps":["trace[724302422] 'range keys from in-memory index tree'  (duration: 200.051157ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.724444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.681701ms","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":"warn","ts":"2026-05-25T14:28:35.724496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.085117ms","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-25T14:28:35.724505Z","caller":"traceutil/trace.go:171","msg":"trace[1124843624] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15692; }","duration":"130.759693ms","start":"2026-05-25T14:28:35.593727Z","end":"2026-05-25T14:28:35.724487Z","steps":["trace[1124843624] 'range keys from in-memory index tree'  (duration: 130.454877ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:28:35.72452Z","caller":"traceutil/trace.go:171","msg":"trace[846226942] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15692; }","duration":"199.137369ms","start":"2026-05-25T14:28:35.525376Z","end":"2026-05-25T14:28:35.724513Z","steps":["trace[846226942] 'range keys from in-memory index tree'  (duration: 198.964545ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.724517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.308783ms","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-25T14:28:35.724585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.306514ms","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-25T14:28:35.724673Z","caller":"traceutil/trace.go:171","msg":"trace[935203945] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15692; }","duration":"150.455177ms","start":"2026-05-25T14:28:35.574196Z","end":"2026-05-25T14:28:35.724651Z","steps":["trace[935203945] 'range keys from in-memory index tree'  (duration: 150.215341ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.724698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.860565ms","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-25T14:28:35.724792Z","caller":"traceutil/trace.go:171","msg":"trace[559289488] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15692; }","duration":"143.061548ms","start":"2026-05-25T14:28:35.581705Z","end":"2026-05-25T14:28:35.724767Z","steps":["trace[559289488] 'range keys from in-memory index tree'  (duration: 142.64445ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:28:35.727761Z","caller":"traceutil/trace.go:171","msg":"trace[649532186] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15692; }","duration":"200.503217ms","start":"2026-05-25T14:28:35.524105Z","end":"2026-05-25T14:28:35.724608Z","steps":["trace[649532186] 'range keys from in-memory index tree'  (duration: 200.19254ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.728291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.191201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-25T14:28:35.728478Z","caller":"traceutil/trace.go:171","msg":"trace[390597102] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15692; }","duration":"154.428105ms","start":"2026-05-25T14:28:35.574031Z","end":"2026-05-25T14:28:35.728459Z","steps":["trace[390597102] 'range keys from in-memory index tree'  (duration: 150.023728ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:28:35.918413Z","caller":"traceutil/trace.go:171","msg":"trace[901057564] linearizableReadLoop","detail":"{readStateIndex:16234; appliedIndex:16233; }","duration":"127.374096ms","start":"2026-05-25T14:28:35.791008Z","end":"2026-05-25T14:28:35.918382Z","steps":["trace[901057564] 'read index received'  (duration: 127.05308ms)","trace[901057564] 'applied index is now lower than readState.Index'  (duration: 319.656µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:28:35.918522Z","caller":"traceutil/trace.go:171","msg":"trace[1428316109] transaction","detail":"{read_only:false; response_revision:15693; number_of_response:1; }","duration":"189.499946ms","start":"2026-05-25T14:28:35.728984Z","end":"2026-05-25T14:28:35.918484Z","steps":["trace[1428316109] 'process raft request'  (duration: 189.17272ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.918682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.5877ms","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-25T14:28:35.918854Z","caller":"traceutil/trace.go:171","msg":"trace[1248804429] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15693; }","duration":"127.845025ms","start":"2026-05-25T14:28:35.790978Z","end":"2026-05-25T14:28:35.918823Z","steps":["trace[1248804429] 'agreement among raft nodes before linearized reading'  (duration: 127.515988ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.918888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.811964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-25T14:28:35.919334Z","caller":"traceutil/trace.go:171","msg":"trace[1756525749] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15693; }","duration":"128.310664ms","start":"2026-05-25T14:28:35.791006Z","end":"2026-05-25T14:28:35.919317Z","steps":["trace[1756525749] 'agreement among raft nodes before linearized reading'  (duration: 127.680272ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:28:35.918961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.315174ms","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-25T14:28:35.919632Z","caller":"traceutil/trace.go:171","msg":"trace[1206832123] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15693; }","duration":"122.038248ms","start":"2026-05-25T14:28:35.797581Z","end":"2026-05-25T14:28:35.919619Z","steps":["trace[1206832123] 'agreement among raft nodes before linearized reading'  (duration: 121.226382ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:32:14.016073Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14836}
{"level":"info","ts":"2026-05-25T14:32:14.113729Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14836,"took":"94.18064ms","hash":2569618472,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":30789632,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-25T14:32:14.113843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2569618472,"revision":14836,"compact-revision":12734}
{"level":"info","ts":"2026-05-25T14:34:39.662372Z","caller":"traceutil/trace.go:171","msg":"trace[2019766382] transaction","detail":"{read_only:false; response_revision:18357; number_of_response:1; }","duration":"174.871236ms","start":"2026-05-25T14:34:39.487469Z","end":"2026-05-25T14:34:39.66234Z","steps":["trace[2019766382] 'process raft request'  (duration: 174.59046ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:34:39.961554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.107672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-55mtc\" ","response":"range_response_count:1 size:22129"}
{"level":"info","ts":"2026-05-25T14:34:39.961642Z","caller":"traceutil/trace.go:171","msg":"trace[2071849123] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-55mtc; range_end:; response_count:1; response_revision:18357; }","duration":"202.250413ms","start":"2026-05-25T14:34:39.759373Z","end":"2026-05-25T14:34:39.961623Z","steps":["trace[2071849123] 'range keys from in-memory index tree'  (duration: 201.760125ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:34:40.17301Z","caller":"traceutil/trace.go:171","msg":"trace[529492971] transaction","detail":"{read_only:false; response_revision:18359; number_of_response:1; }","duration":"152.842356ms","start":"2026-05-25T14:34:40.02012Z","end":"2026-05-25T14:34:40.172962Z","steps":["trace[529492971] 'process raft request'  (duration: 117.679723ms)","trace[529492971] 'compare'  (duration: 34.854567ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:36:18.4138Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T14:36:18.421105Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-25T14:36:18.421222Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-25T14:37:14.022865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17378}
{"level":"info","ts":"2026-05-25T14:37:14.1248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17378,"took":"97.871696ms","hash":4037806585,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":34836480,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-25T14:37:14.124872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4037806585,"revision":17378,"compact-revision":14836}
{"level":"info","ts":"2026-05-25T14:40:34.638623Z","caller":"traceutil/trace.go:171","msg":"trace[1035953697] transaction","detail":"{read_only:false; response_revision:21089; number_of_response:1; }","duration":"122.32438ms","start":"2026-05-25T14:40:34.516264Z","end":"2026-05-25T14:40:34.638588Z","steps":["trace[1035953697] 'process raft request'  (duration: 122.026234ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.352949Z","caller":"traceutil/trace.go:171","msg":"trace[1042487387] transaction","detail":"{read_only:false; response_revision:21117; number_of_response:1; }","duration":"133.986363ms","start":"2026-05-25T14:40:40.218697Z","end":"2026-05-25T14:40:40.352683Z","steps":["trace[1042487387] 'process raft request'  (duration: 133.776538ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.549589Z","caller":"traceutil/trace.go:171","msg":"trace[2082006156] transaction","detail":"{read_only:false; response_revision:21118; number_of_response:1; }","duration":"238.278802ms","start":"2026-05-25T14:40:40.311281Z","end":"2026-05-25T14:40:40.54956Z","steps":["trace[2082006156] 'process raft request'  (duration: 213.70889ms)","trace[2082006156] 'compare'  (duration: 24.286467ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:40:40.549853Z","caller":"traceutil/trace.go:171","msg":"trace[432431595] transaction","detail":"{read_only:false; response_revision:21119; number_of_response:1; }","duration":"237.67023ms","start":"2026-05-25T14:40:40.31214Z","end":"2026-05-25T14:40:40.54981Z","steps":["trace[432431595] 'process raft request'  (duration: 237.373564ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.609974Z","caller":"traceutil/trace.go:171","msg":"trace[1356932157] transaction","detail":"{read_only:false; response_revision:21120; number_of_response:1; }","duration":"209.207179ms","start":"2026-05-25T14:40:40.400743Z","end":"2026-05-25T14:40:40.60995Z","steps":["trace[1356932157] 'process raft request'  (duration: 209.038056ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:40:40.852452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.506945ms","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-25T14:40:40.852516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.078477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-25T14:40:40.852523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.073596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-25T14:40:40.852624Z","caller":"traceutil/trace.go:171","msg":"trace[1125923279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21120; }","duration":"183.7091ms","start":"2026-05-25T14:40:40.668879Z","end":"2026-05-25T14:40:40.852588Z","steps":["trace[1125923279] 'range keys from in-memory index tree'  (duration: 183.186829ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.852631Z","caller":"traceutil/trace.go:171","msg":"trace[1275255906] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21120; }","duration":"186.293041ms","start":"2026-05-25T14:40:40.666313Z","end":"2026-05-25T14:40:40.852606Z","steps":["trace[1275255906] 'range keys from in-memory index tree'  (duration: 185.830472ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.852649Z","caller":"traceutil/trace.go:171","msg":"trace[1224817996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21120; }","duration":"185.26679ms","start":"2026-05-25T14:40:40.667356Z","end":"2026-05-25T14:40:40.852623Z","steps":["trace[1224817996] 'range keys from in-memory index tree'  (duration: 184.837271ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.968592Z","caller":"traceutil/trace.go:171","msg":"trace[1885165013] transaction","detail":"{read_only:false; response_revision:21121; number_of_response:1; }","duration":"110.510122ms","start":"2026-05-25T14:40:40.858061Z","end":"2026-05-25T14:40:40.968571Z","steps":["trace[1885165013] 'process raft request'  (duration: 110.344519ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.97271Z","caller":"traceutil/trace.go:171","msg":"trace[1435025137] transaction","detail":"{read_only:false; response_revision:21123; number_of_response:1; }","duration":"113.507763ms","start":"2026-05-25T14:40:40.85917Z","end":"2026-05-25T14:40:40.972678Z","steps":["trace[1435025137] 'process raft request'  (duration: 113.445252ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:40:40.9728Z","caller":"traceutil/trace.go:171","msg":"trace[2050846984] transaction","detail":"{read_only:false; response_revision:21122; number_of_response:1; }","duration":"114.144916ms","start":"2026-05-25T14:40:40.858589Z","end":"2026-05-25T14:40:40.972734Z","steps":["trace[2050846984] 'process raft request'  (duration: 113.84116ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:42:14.028536Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19706}
{"level":"info","ts":"2026-05-25T14:42:14.143675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19706,"took":"108.8284ms","hash":3696644918,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":29798400,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-25T14:42:14.143756Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3696644918,"revision":19706,"compact-revision":17378}
{"level":"info","ts":"2026-05-25T14:44:37.189376Z","caller":"traceutil/trace.go:171","msg":"trace[2147122314] transaction","detail":"{read_only:false; response_revision:23548; number_of_response:1; }","duration":"132.532815ms","start":"2026-05-25T14:44:37.056805Z","end":"2026-05-25T14:44:37.189337Z","steps":["trace[2147122314] 'process raft request'  (duration: 132.301451ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:47:14.035534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21927}
{"level":"info","ts":"2026-05-25T14:47:14.148725Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21927,"took":"106.066092ms","hash":3571354018,"current-db-size-bytes":58966016,"current-db-size":"59 MB","current-db-size-in-use-bytes":43286528,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-05-25T14:47:14.148808Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3571354018,"revision":21927,"compact-revision":19706}
{"level":"info","ts":"2026-05-25T14:47:57.311832Z","caller":"traceutil/trace.go:171","msg":"trace[1215707532] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"105.948279ms","start":"2026-05-25T14:47:57.205848Z","end":"2026-05-25T14:47:57.311796Z","steps":["trace[1215707532] 'process raft request'  (duration: 104.149954ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:47:57.88616Z","caller":"traceutil/trace.go:171","msg":"trace[929587534] linearizableReadLoop","detail":"{readStateIndex:26457; appliedIndex:26456; }","duration":"107.285816ms","start":"2026-05-25T14:47:57.77885Z","end":"2026-05-25T14:47:57.886136Z","steps":["trace[929587534] 'read index received'  (duration: 107.192454ms)","trace[929587534] 'applied index is now lower than readState.Index'  (duration: 91.802µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:47:57.886285Z","caller":"traceutil/trace.go:171","msg":"trace[1319865194] transaction","detail":"{read_only:false; response_revision:25607; number_of_response:1; }","duration":"132.089782ms","start":"2026-05-25T14:47:57.754153Z","end":"2026-05-25T14:47:57.886243Z","steps":["trace[1319865194] 'process raft request'  (duration: 131.814526ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:47:57.886322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.453819ms","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-25T14:47:57.886371Z","caller":"traceutil/trace.go:171","msg":"trace[394827259] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25607; }","duration":"107.568771ms","start":"2026-05-25T14:47:57.77879Z","end":"2026-05-25T14:47:57.886359Z","steps":["trace[394827259] 'agreement among raft nodes before linearized reading'  (duration: 107.470459ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:47:58.087657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.96706ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190072 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25572 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T14:47:58.087795Z","caller":"traceutil/trace.go:171","msg":"trace[2084083644] linearizableReadLoop","detail":"{readStateIndex:26458; appliedIndex:26457; }","duration":"201.533261ms","start":"2026-05-25T14:47:57.886237Z","end":"2026-05-25T14:47:58.08777Z","steps":["trace[2084083644] 'read index received'  (duration: 44.217364ms)","trace[2084083644] 'applied index is now lower than readState.Index'  (duration: 157.314507ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:47:58.087916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.403719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:47:58.087895Z","caller":"traceutil/trace.go:171","msg":"trace[1221440632] transaction","detail":"{read_only:false; response_revision:25608; number_of_response:1; }","duration":"203.081902ms","start":"2026-05-25T14:47:57.884758Z","end":"2026-05-25T14:47:58.08784Z","steps":["trace[1221440632] 'process raft request'  (duration: 45.760725ms)","trace[1221440632] 'compare'  (duration: 156.720535ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:47:58.087951Z","caller":"traceutil/trace.go:171","msg":"trace[904584831] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:25608; }","duration":"205.489971ms","start":"2026-05-25T14:47:57.882451Z","end":"2026-05-25T14:47:58.087941Z","steps":["trace[904584831] 'agreement among raft nodes before linearized reading'  (duration: 205.416859ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:47:58.342353Z","caller":"traceutil/trace.go:171","msg":"trace[323186533] linearizableReadLoop","detail":"{readStateIndex:26459; appliedIndex:26458; }","duration":"254.478601ms","start":"2026-05-25T14:47:58.087828Z","end":"2026-05-25T14:47:58.342307Z","steps":["trace[323186533] 'read index received'  (duration: 254.285387ms)","trace[323186533] 'applied index is now lower than readState.Index'  (duration: 191.194µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:47:58.3424Z","caller":"traceutil/trace.go:171","msg":"trace[705501782] transaction","detail":"{read_only:false; response_revision:25609; number_of_response:1; }","duration":"255.896098ms","start":"2026-05-25T14:47:58.086461Z","end":"2026-05-25T14:47:58.342357Z","steps":["trace[705501782] 'process raft request'  (duration: 255.650763ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:47:58.342593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.738276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-messaging-topology-operator\" ","response":"range_response_count:1 size:1115"}
{"level":"info","ts":"2026-05-25T14:47:58.342716Z","caller":"traceutil/trace.go:171","msg":"trace[496432133] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-messaging-topology-operator; range_end:; response_count:1; response_revision:25609; }","duration":"422.929549ms","start":"2026-05-25T14:47:57.919758Z","end":"2026-05-25T14:47:58.342688Z","steps":["trace[496432133] 'agreement among raft nodes before linearized reading'  (duration: 422.695295ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:47:58.342762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:47:57.919728Z","time spent":"423.024781ms","remote":"127.0.0.1:49788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1139,"request content":"key:\"/registry/serviceaccounts/openstack/rabbitmq-messaging-topology-operator\" "}
{"level":"info","ts":"2026-05-25T14:47:58.344011Z","caller":"traceutil/trace.go:171","msg":"trace[1460513148] transaction","detail":"{read_only:false; response_revision:25610; number_of_response:1; }","duration":"202.324198ms","start":"2026-05-25T14:47:58.141667Z","end":"2026-05-25T14:47:58.343992Z","steps":["trace[1460513148] 'process raft request'  (duration: 201.859978ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:02.630436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.077503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-25T14:48:02.630533Z","caller":"traceutil/trace.go:171","msg":"trace[900912196] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25643; }","duration":"128.232875ms","start":"2026-05-25T14:48:02.502278Z","end":"2026-05-25T14:48:02.630511Z","steps":["trace[900912196] 'range keys from in-memory index tree'  (duration: 127.867408ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:02.778052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.382617ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190163 > lease_revoke:<id:38c19e5f6ce907c3>","response":"size:30"}
{"level":"info","ts":"2026-05-25T14:48:02.778566Z","caller":"traceutil/trace.go:171","msg":"trace[1576848203] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"142.028352ms","start":"2026-05-25T14:48:02.636492Z","end":"2026-05-25T14:48:02.778521Z","steps":["trace[1576848203] 'process raft request'  (duration: 141.689314ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:02.962042Z","caller":"traceutil/trace.go:171","msg":"trace[860369831] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"106.01131ms","start":"2026-05-25T14:48:02.855997Z","end":"2026-05-25T14:48:02.962008Z","steps":["trace[860369831] 'process raft request'  (duration: 105.731115ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:03.251105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.827647ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190167 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25608 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T14:48:03.251287Z","caller":"traceutil/trace.go:171","msg":"trace[383557103] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"157.758595ms","start":"2026-05-25T14:48:03.093499Z","end":"2026-05-25T14:48:03.251257Z","steps":["trace[383557103] 'process raft request'  (duration: 17.629372ms)","trace[383557103] 'compare'  (duration: 139.625203ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:03.485925Z","caller":"traceutil/trace.go:171","msg":"trace[1588565581] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"121.907668ms","start":"2026-05-25T14:48:03.36399Z","end":"2026-05-25T14:48:03.485898Z","steps":["trace[1588565581] 'process raft request'  (duration: 121.658303ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:03.713098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.436719ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190172 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25635 > 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-25T14:48:03.713353Z","caller":"traceutil/trace.go:171","msg":"trace[1117977280] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"221.322557ms","start":"2026-05-25T14:48:03.49201Z","end":"2026-05-25T14:48:03.713333Z","steps":["trace[1117977280] 'process raft request'  (duration: 221.281176ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:03.713586Z","caller":"traceutil/trace.go:171","msg":"trace[576662526] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"221.867528ms","start":"2026-05-25T14:48:03.491707Z","end":"2026-05-25T14:48:03.713574Z","steps":["trace[576662526] 'process raft request'  (duration: 77.382778ms)","trace[576662526] 'compare'  (duration: 143.116833ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:03.71373Z","caller":"traceutil/trace.go:171","msg":"trace[2043442643] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"221.794307ms","start":"2026-05-25T14:48:03.491919Z","end":"2026-05-25T14:48:03.713713Z","steps":["trace[2043442643] 'process raft request'  (duration: 221.313417ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:04.099415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.702845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:04.09955Z","caller":"traceutil/trace.go:171","msg":"trace[1896390229] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25651; }","duration":"116.882688ms","start":"2026-05-25T14:48:03.982639Z","end":"2026-05-25T14:48:04.099522Z","steps":["trace[1896390229] 'count revisions from in-memory index tree'  (duration: 116.588322ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:04.099641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.060341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:04.09979Z","caller":"traceutil/trace.go:171","msg":"trace[414874662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25651; }","duration":"122.281945ms","start":"2026-05-25T14:48:03.977484Z","end":"2026-05-25T14:48:04.099766Z","steps":["trace[414874662] 'range keys from in-memory index tree'  (duration: 121.588142ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:04.561652Z","caller":"traceutil/trace.go:171","msg":"trace[627646168] linearizableReadLoop","detail":"{readStateIndex:26504; appliedIndex:26503; }","duration":"141.347537ms","start":"2026-05-25T14:48:04.420279Z","end":"2026-05-25T14:48:04.561627Z","steps":["trace[627646168] 'read index received'  (duration: 141.195344ms)","trace[627646168] 'applied index is now lower than readState.Index'  (duration: 151.103µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:04.561714Z","caller":"traceutil/trace.go:171","msg":"trace[238811292] transaction","detail":"{read_only:false; response_revision:25653; number_of_response:1; }","duration":"195.281727ms","start":"2026-05-25T14:48:04.366392Z","end":"2026-05-25T14:48:04.561674Z","steps":["trace[238811292] 'process raft request'  (duration: 195.021292ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:04.562224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.895957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-25T14:48:04.562353Z","caller":"traceutil/trace.go:171","msg":"trace[197705574] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:25653; }","duration":"142.106472ms","start":"2026-05-25T14:48:04.420216Z","end":"2026-05-25T14:48:04.562322Z","steps":["trace[197705574] 'agreement among raft nodes before linearized reading'  (duration: 141.53116ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:04.562833Z","caller":"traceutil/trace.go:171","msg":"trace[1219294113] transaction","detail":"{read_only:false; response_revision:25654; number_of_response:1; }","duration":"129.852728ms","start":"2026-05-25T14:48:04.432962Z","end":"2026-05-25T14:48:04.562815Z","steps":["trace[1219294113] 'process raft request'  (duration: 129.692634ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:04.563154Z","caller":"traceutil/trace.go:171","msg":"trace[1128927008] transaction","detail":"{read_only:false; response_revision:25655; number_of_response:1; }","duration":"128.42855ms","start":"2026-05-25T14:48:04.434709Z","end":"2026-05-25T14:48:04.563137Z","steps":["trace[1128927008] 'process raft request'  (duration: 128.044702ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:04.563563Z","caller":"traceutil/trace.go:171","msg":"trace[1077247365] transaction","detail":"{read_only:false; response_revision:25656; number_of_response:1; }","duration":"127.359308ms","start":"2026-05-25T14:48:04.436167Z","end":"2026-05-25T14:48:04.563526Z","steps":["trace[1077247365] 'process raft request'  (duration: 126.94195ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:04.563738Z","caller":"traceutil/trace.go:171","msg":"trace[1572085978] transaction","detail":"{read_only:false; response_revision:25657; number_of_response:1; }","duration":"126.918299ms","start":"2026-05-25T14:48:04.436798Z","end":"2026-05-25T14:48:04.563716Z","steps":["trace[1572085978] 'process raft request'  (duration: 126.658444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:04.874214Z","caller":"traceutil/trace.go:171","msg":"trace[844337946] transaction","detail":"{read_only:false; response_revision:25658; number_of_response:1; }","duration":"273.562712ms","start":"2026-05-25T14:48:04.600612Z","end":"2026-05-25T14:48:04.874175Z","steps":["trace[844337946] 'process raft request'  (duration: 273.321777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:05.179029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.96338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-25T14:48:05.179144Z","caller":"traceutil/trace.go:171","msg":"trace[187045378] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25659; }","duration":"118.157895ms","start":"2026-05-25T14:48:05.060962Z","end":"2026-05-25T14:48:05.17912Z","steps":["trace[187045378] 'count revisions from in-memory index tree'  (duration: 117.756446ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:05.179194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.859559ms","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-25T14:48:05.179293Z","caller":"traceutil/trace.go:171","msg":"trace[740268646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25659; }","duration":"211.973761ms","start":"2026-05-25T14:48:04.967294Z","end":"2026-05-25T14:48:05.179267Z","steps":["trace[740268646] 'range keys from in-memory index tree'  (duration: 211.599983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:05.179429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.757897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:05.179549Z","caller":"traceutil/trace.go:171","msg":"trace[168189475] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:25659; }","duration":"138.920039ms","start":"2026-05-25T14:48:05.04061Z","end":"2026-05-25T14:48:05.17953Z","steps":["trace[168189475] 'count revisions from in-memory index tree'  (duration: 138.597324ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:05.977001Z","caller":"traceutil/trace.go:171","msg":"trace[651231677] linearizableReadLoop","detail":"{readStateIndex:26516; appliedIndex:26513; }","duration":"225.612472ms","start":"2026-05-25T14:48:05.75135Z","end":"2026-05-25T14:48:05.976963Z","steps":["trace[651231677] 'read index received'  (duration: 34.52549ms)","trace[651231677] 'applied index is now lower than readState.Index'  (duration: 191.082322ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:05.977012Z","caller":"traceutil/trace.go:171","msg":"trace[1373841702] transaction","detail":"{read_only:false; response_revision:25664; number_of_response:1; }","duration":"252.916099ms","start":"2026-05-25T14:48:05.724052Z","end":"2026-05-25T14:48:05.976969Z","steps":["trace[1373841702] 'process raft request'  (duration: 236.614123ms)","trace[1373841702] 'compare'  (duration: 15.955939ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:05.977017Z","caller":"traceutil/trace.go:171","msg":"trace[504076657] transaction","detail":"{read_only:false; response_revision:25665; number_of_response:1; }","duration":"251.664954ms","start":"2026-05-25T14:48:05.725309Z","end":"2026-05-25T14:48:05.976974Z","steps":["trace[504076657] 'process raft request'  (duration: 251.4785ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:05.977237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.862487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:05.977282Z","caller":"traceutil/trace.go:171","msg":"trace[265983523] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25666; }","duration":"225.931338ms","start":"2026-05-25T14:48:05.751332Z","end":"2026-05-25T14:48:05.977264Z","steps":["trace[265983523] 'agreement among raft nodes before linearized reading'  (duration: 225.810476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:05.97733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.560831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:176"}
{"level":"info","ts":"2026-05-25T14:48:05.977483Z","caller":"traceutil/trace.go:171","msg":"trace[431327654] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:25666; }","duration":"158.778176ms","start":"2026-05-25T14:48:05.818682Z","end":"2026-05-25T14:48:05.97746Z","steps":["trace[431327654] 'agreement among raft nodes before linearized reading'  (duration: 158.50687ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:06.289528Z","caller":"traceutil/trace.go:171","msg":"trace[1875303982] transaction","detail":"{read_only:false; response_revision:25669; number_of_response:1; }","duration":"226.905019ms","start":"2026-05-25T14:48:06.062591Z","end":"2026-05-25T14:48:06.289496Z","steps":["trace[1875303982] 'process raft request'  (duration: 226.720435ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:06.312503Z","caller":"traceutil/trace.go:171","msg":"trace[893419191] transaction","detail":"{read_only:false; response_revision:25670; number_of_response:1; }","duration":"159.48429ms","start":"2026-05-25T14:48:06.152993Z","end":"2026-05-25T14:48:06.312478Z","steps":["trace[893419191] 'process raft request'  (duration: 159.061242ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:06.49121Z","caller":"traceutil/trace.go:171","msg":"trace[2081219366] transaction","detail":"{read_only:false; response_revision:25671; number_of_response:1; }","duration":"174.217355ms","start":"2026-05-25T14:48:06.316958Z","end":"2026-05-25T14:48:06.491175Z","steps":["trace[2081219366] 'process raft request'  (duration: 124.867967ms)","trace[2081219366] 'compare'  (duration: 49.180534ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:06.584405Z","caller":"traceutil/trace.go:171","msg":"trace[64375670] transaction","detail":"{read_only:false; response_revision:25672; number_of_response:1; }","duration":"182.742106ms","start":"2026-05-25T14:48:06.401576Z","end":"2026-05-25T14:48:06.584318Z","steps":["trace[64375670] 'process raft request'  (duration: 182.184985ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:06.584524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.99236ms","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-25T14:48:06.584576Z","caller":"traceutil/trace.go:171","msg":"trace[1321763554] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25672; }","duration":"158.095082ms","start":"2026-05-25T14:48:06.426468Z","end":"2026-05-25T14:48:06.584564Z","steps":["trace[1321763554] 'agreement among raft nodes before linearized reading'  (duration: 157.889738ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:06.584263Z","caller":"traceutil/trace.go:171","msg":"trace[652815472] linearizableReadLoop","detail":"{readStateIndex:26523; appliedIndex:26521; }","duration":"157.729795ms","start":"2026-05-25T14:48:06.426508Z","end":"2026-05-25T14:48:06.584238Z","steps":["trace[652815472] 'read index received'  (duration: 15.340367ms)","trace[652815472] 'applied index is now lower than readState.Index'  (duration: 142.387848ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:07.042724Z","caller":"traceutil/trace.go:171","msg":"trace[887741956] transaction","detail":"{read_only:false; response_revision:25678; number_of_response:1; }","duration":"139.426969ms","start":"2026-05-25T14:48:06.903265Z","end":"2026-05-25T14:48:07.042692Z","steps":["trace[887741956] 'process raft request'  (duration: 139.240265ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:07.428337Z","caller":"traceutil/trace.go:171","msg":"trace[1269988233] linearizableReadLoop","detail":"{readStateIndex:26532; appliedIndex:26530; }","duration":"117.239765ms","start":"2026-05-25T14:48:07.311066Z","end":"2026-05-25T14:48:07.428306Z","steps":["trace[1269988233] 'read index received'  (duration: 95.694134ms)","trace[1269988233] 'applied index is now lower than readState.Index'  (duration: 21.544521ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:07.428743Z","caller":"traceutil/trace.go:171","msg":"trace[682648402] transaction","detail":"{read_only:false; response_revision:25679; number_of_response:1; }","duration":"164.119663ms","start":"2026-05-25T14:48:07.264586Z","end":"2026-05-25T14:48:07.428705Z","steps":["trace[682648402] 'process raft request'  (duration: 142.191175ms)","trace[682648402] 'compare'  (duration: 21.150292ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:07.428788Z","caller":"traceutil/trace.go:171","msg":"trace[1857900985] transaction","detail":"{read_only:false; response_revision:25680; number_of_response:1; }","duration":"157.94482ms","start":"2026-05-25T14:48:07.270792Z","end":"2026-05-25T14:48:07.428736Z","steps":["trace[1857900985] 'process raft request'  (duration: 157.400508ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:07.428844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.743365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:07.428896Z","caller":"traceutil/trace.go:171","msg":"trace[995709489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25680; }","duration":"117.877958ms","start":"2026-05-25T14:48:07.311006Z","end":"2026-05-25T14:48:07.428884Z","steps":["trace[995709489] 'agreement among raft nodes before linearized reading'  (duration: 117.435948ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:08.241093Z","caller":"traceutil/trace.go:171","msg":"trace[600061808] transaction","detail":"{read_only:false; response_revision:25684; number_of_response:1; }","duration":"226.263786ms","start":"2026-05-25T14:48:08.014793Z","end":"2026-05-25T14:48:08.241057Z","steps":["trace[600061808] 'process raft request'  (duration: 143.875857ms)","trace[600061808] 'compare'  (duration: 81.591172ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:08.241217Z","caller":"traceutil/trace.go:171","msg":"trace[2097505003] transaction","detail":"{read_only:false; response_revision:25685; number_of_response:1; }","duration":"226.095093ms","start":"2026-05-25T14:48:08.01508Z","end":"2026-05-25T14:48:08.241175Z","steps":["trace[2097505003] 'process raft request'  (duration: 225.91784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:08.548469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.51622ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190266 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25646 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T14:48:08.548608Z","caller":"traceutil/trace.go:171","msg":"trace[1244398431] linearizableReadLoop","detail":"{readStateIndex:26538; appliedIndex:26537; }","duration":"237.398707ms","start":"2026-05-25T14:48:08.311189Z","end":"2026-05-25T14:48:08.548588Z","steps":["trace[1244398431] 'read index received'  (duration: 81.593822ms)","trace[1244398431] 'applied index is now lower than readState.Index'  (duration: 155.803025ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:08.548722Z","caller":"traceutil/trace.go:171","msg":"trace[946522528] transaction","detail":"{read_only:false; response_revision:25686; number_of_response:1; }","duration":"290.643933ms","start":"2026-05-25T14:48:08.258037Z","end":"2026-05-25T14:48:08.548681Z","steps":["trace[946522528] 'process raft request'  (duration: 134.805407ms)","trace[946522528] 'compare'  (duration: 154.944339ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:08.548817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.112292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-25T14:48:08.548857Z","caller":"traceutil/trace.go:171","msg":"trace[1855408862] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25686; }","duration":"117.147362ms","start":"2026-05-25T14:48:08.431694Z","end":"2026-05-25T14:48:08.548842Z","steps":["trace[1855408862] 'agreement among raft nodes before linearized reading'  (duration: 117.089841ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:08.54876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.581102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:08.548998Z","caller":"traceutil/trace.go:171","msg":"trace[114236299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25686; }","duration":"237.861906ms","start":"2026-05-25T14:48:08.311124Z","end":"2026-05-25T14:48:08.548986Z","steps":["trace[114236299] 'agreement among raft nodes before linearized reading'  (duration: 237.588341ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:08.807209Z","caller":"traceutil/trace.go:171","msg":"trace[388588392] transaction","detail":"{read_only:false; response_revision:25688; number_of_response:1; }","duration":"170.947559ms","start":"2026-05-25T14:48:08.636238Z","end":"2026-05-25T14:48:08.807186Z","steps":["trace[388588392] 'process raft request'  (duration: 169.077601ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:08.807682Z","caller":"traceutil/trace.go:171","msg":"trace[1522930218] transaction","detail":"{read_only:false; response_revision:25689; number_of_response:1; }","duration":"171.168024ms","start":"2026-05-25T14:48:08.636455Z","end":"2026-05-25T14:48:08.807623Z","steps":["trace[1522930218] 'process raft request'  (duration: 170.693984ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:08.807773Z","caller":"traceutil/trace.go:171","msg":"trace[2046122875] transaction","detail":"{read_only:false; response_revision:25690; number_of_response:1; }","duration":"171.212135ms","start":"2026-05-25T14:48:08.636522Z","end":"2026-05-25T14:48:08.807734Z","steps":["trace[2046122875] 'process raft request'  (duration: 170.94851ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:08.80781Z","caller":"traceutil/trace.go:171","msg":"trace[1310800905] transaction","detail":"{read_only:false; response_revision:25692; number_of_response:1; }","duration":"170.822327ms","start":"2026-05-25T14:48:08.636955Z","end":"2026-05-25T14:48:08.807777Z","steps":["trace[1310800905] 'process raft request'  (duration: 170.757386ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:08.807924Z","caller":"traceutil/trace.go:171","msg":"trace[89444759] transaction","detail":"{read_only:false; response_revision:25691; number_of_response:1; }","duration":"171.306016ms","start":"2026-05-25T14:48:08.636608Z","end":"2026-05-25T14:48:08.807914Z","steps":["trace[89444759] 'process raft request'  (duration: 171.040691ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:15.298831Z","caller":"traceutil/trace.go:171","msg":"trace[836999055] transaction","detail":"{read_only:false; response_revision:25735; number_of_response:1; }","duration":"212.014011ms","start":"2026-05-25T14:48:15.086782Z","end":"2026-05-25T14:48:15.298796Z","steps":["trace[836999055] 'process raft request'  (duration: 211.780927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:15.648378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.555263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129352"}
{"level":"info","ts":"2026-05-25T14:48:15.648458Z","caller":"traceutil/trace.go:171","msg":"trace[1708124893] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:25735; }","duration":"163.693855ms","start":"2026-05-25T14:48:15.484747Z","end":"2026-05-25T14:48:15.648441Z","steps":["trace[1708124893] 'range keys from in-memory index tree'  (duration: 163.302287ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:15.648859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.138404ms","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-25T14:48:15.648865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.713385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-05-25T14:48:15.648894Z","caller":"traceutil/trace.go:171","msg":"trace[1227262305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25735; }","duration":"172.225355ms","start":"2026-05-25T14:48:15.476661Z","end":"2026-05-25T14:48:15.648887Z","steps":["trace[1227262305] 'range keys from in-memory index tree'  (duration: 172.012422ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:15.648917Z","caller":"traceutil/trace.go:171","msg":"trace[1685659802] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:25735; }","duration":"244.829987ms","start":"2026-05-25T14:48:15.404073Z","end":"2026-05-25T14:48:15.648903Z","steps":["trace[1685659802] 'range keys from in-memory index tree'  (duration: 244.48792ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:15.880873Z","caller":"traceutil/trace.go:171","msg":"trace[1945911018] transaction","detail":"{read_only:false; response_revision:25736; number_of_response:1; }","duration":"227.009901ms","start":"2026-05-25T14:48:15.653814Z","end":"2026-05-25T14:48:15.880824Z","steps":["trace[1945911018] 'process raft request'  (duration: 226.754396ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:15.881026Z","caller":"traceutil/trace.go:171","msg":"trace[514357548] linearizableReadLoop","detail":"{readStateIndex:26589; appliedIndex:26588; }","duration":"226.875039ms","start":"2026-05-25T14:48:15.653868Z","end":"2026-05-25T14:48:15.880743Z","steps":["trace[514357548] 'read index received'  (duration: 226.662434ms)","trace[514357548] 'applied index is now lower than readState.Index'  (duration: 211.644µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:15.881457Z","caller":"traceutil/trace.go:171","msg":"trace[1537207725] transaction","detail":"{read_only:false; response_revision:25737; number_of_response:1; }","duration":"227.541892ms","start":"2026-05-25T14:48:15.653868Z","end":"2026-05-25T14:48:15.88141Z","steps":["trace[1537207725] 'process raft request'  (duration: 227.308497ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:15.882111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.052102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:90 size:118812"}
{"level":"warn","ts":"2026-05-25T14:48:15.882092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.175814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:90 size:118812"}
{"level":"info","ts":"2026-05-25T14:48:15.882217Z","caller":"traceutil/trace.go:171","msg":"trace[2055823835] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:90; response_revision:25736; }","duration":"228.343747ms","start":"2026-05-25T14:48:15.653846Z","end":"2026-05-25T14:48:15.882189Z","steps":["trace[2055823835] 'agreement among raft nodes before linearized reading'  (duration: 227.167994ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:15.882163Z","caller":"traceutil/trace.go:171","msg":"trace[612148297] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:90; response_revision:25737; }","duration":"228.179474ms","start":"2026-05-25T14:48:15.653973Z","end":"2026-05-25T14:48:15.882153Z","steps":["trace[612148297] 'agreement among raft nodes before linearized reading'  (duration: 227.417119ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:16.18219Z","caller":"traceutil/trace.go:171","msg":"trace[496044276] transaction","detail":"{read_only:false; response_revision:25738; number_of_response:1; }","duration":"292.533511ms","start":"2026-05-25T14:48:15.889622Z","end":"2026-05-25T14:48:16.182156Z","steps":["trace[496044276] 'process raft request'  (duration: 292.374828ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:16.182757Z","caller":"traceutil/trace.go:171","msg":"trace[791912744] linearizableReadLoop","detail":"{readStateIndex:26591; appliedIndex:26591; }","duration":"290.324646ms","start":"2026-05-25T14:48:15.89242Z","end":"2026-05-25T14:48:16.182744Z","steps":["trace[791912744] 'read index received'  (duration: 290.319056ms)","trace[791912744] 'applied index is now lower than readState.Index'  (duration: 4.9µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:16.182941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.497241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-05-25T14:48:16.182974Z","caller":"traceutil/trace.go:171","msg":"trace[209204147] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:25738; }","duration":"290.564403ms","start":"2026-05-25T14:48:15.892397Z","end":"2026-05-25T14:48:16.182962Z","steps":["trace[209204147] 'agreement among raft nodes before linearized reading'  (duration: 290.41766ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:16.195327Z","caller":"traceutil/trace.go:171","msg":"trace[628865267] transaction","detail":"{read_only:false; response_revision:25739; number_of_response:1; }","duration":"148.726265ms","start":"2026-05-25T14:48:16.046556Z","end":"2026-05-25T14:48:16.195282Z","steps":["trace[628865267] 'process raft request'  (duration: 148.337617ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:16.195416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.920319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129352"}
{"level":"info","ts":"2026-05-25T14:48:16.195514Z","caller":"traceutil/trace.go:171","msg":"trace[826760608] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:25739; }","duration":"303.078472ms","start":"2026-05-25T14:48:15.892418Z","end":"2026-05-25T14:48:16.195497Z","steps":["trace[826760608] 'agreement among raft nodes before linearized reading'  (duration: 302.702874ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:16.195553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:15.892397Z","time spent":"303.147864ms","remote":"127.0.0.1:49644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":129376,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-05-25T14:48:16.782612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.682445ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190392 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25728 > 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-25T14:48:16.782928Z","caller":"traceutil/trace.go:171","msg":"trace[296421866] linearizableReadLoop","detail":"{readStateIndex:26594; appliedIndex:26592; }","duration":"471.378059ms","start":"2026-05-25T14:48:16.311486Z","end":"2026-05-25T14:48:16.782864Z","steps":["trace[296421866] 'read index received'  (duration: 204.305697ms)","trace[296421866] 'applied index is now lower than readState.Index'  (duration: 267.071032ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:16.783096Z","caller":"traceutil/trace.go:171","msg":"trace[345917707] transaction","detail":"{read_only:false; response_revision:25741; number_of_response:1; }","duration":"502.352989ms","start":"2026-05-25T14:48:16.280689Z","end":"2026-05-25T14:48:16.783042Z","steps":["trace[345917707] 'process raft request'  (duration: 502.058203ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:16.783225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.280645Z","time spent":"502.491082ms","remote":"127.0.0.1:49846","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:25727 > 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-25T14:48:16.783057Z","caller":"traceutil/trace.go:171","msg":"trace[1910620264] transaction","detail":"{read_only:false; response_revision:25740; number_of_response:1; }","duration":"502.465771ms","start":"2026-05-25T14:48:16.280543Z","end":"2026-05-25T14:48:16.783008Z","steps":["trace[1910620264] 'process raft request'  (duration: 235.275326ms)","trace[1910620264] 'compare'  (duration: 265.902069ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:16.783548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.280517Z","time spent":"502.952781ms","remote":"127.0.0.1:49846","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:25728 > 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-25T14:48:16.783664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.090364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:16.786213Z","caller":"traceutil/trace.go:171","msg":"trace[993872536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25741; }","duration":"474.771387ms","start":"2026-05-25T14:48:16.311421Z","end":"2026-05-25T14:48:16.786192Z","steps":["trace[993872536] 'agreement among raft nodes before linearized reading'  (duration: 472.018062ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:16.786496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.311395Z","time spent":"474.987252ms","remote":"127.0.0.1:49582","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-25T14:48:16.80439Z","caller":"traceutil/trace.go:171","msg":"trace[1443532363] transaction","detail":"{read_only:false; response_revision:25742; number_of_response:1; }","duration":"122.149463ms","start":"2026-05-25T14:48:16.682209Z","end":"2026-05-25T14:48:16.804359Z","steps":["trace[1443532363] 'process raft request'  (duration: 121.936379ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:17.179506Z","caller":"traceutil/trace.go:171","msg":"trace[267983911] linearizableReadLoop","detail":"{readStateIndex:26596; appliedIndex:26594; }","duration":"396.45768ms","start":"2026-05-25T14:48:16.783Z","end":"2026-05-25T14:48:17.179458Z","steps":["trace[267983911] 'read index received'  (duration: 21.060421ms)","trace[267983911] 'applied index is now lower than readState.Index'  (duration: 375.395729ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:17.179689Z","caller":"traceutil/trace.go:171","msg":"trace[2087493968] transaction","detail":"{read_only:false; response_revision:25743; number_of_response:1; }","duration":"468.628594ms","start":"2026-05-25T14:48:16.711038Z","end":"2026-05-25T14:48:17.179666Z","steps":["trace[2087493968] 'process raft request'  (duration: 468.225656ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.17971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.706355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:17.179801Z","caller":"traceutil/trace.go:171","msg":"trace[736593062] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25743; }","duration":"598.825117ms","start":"2026-05-25T14:48:16.580954Z","end":"2026-05-25T14:48:17.179779Z","steps":["trace[736593062] 'agreement among raft nodes before linearized reading'  (duration: 598.633854ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.17987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.580693Z","time spent":"599.168524ms","remote":"127.0.0.1:59980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "}
{"level":"warn","ts":"2026-05-25T14:48:17.17998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.711024Z","time spent":"468.735496ms","remote":"127.0.0.1:49846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25670 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-25T14:48:17.202929Z","caller":"traceutil/trace.go:171","msg":"trace[553404021] transaction","detail":"{read_only:false; response_revision:25745; number_of_response:1; }","duration":"364.181105ms","start":"2026-05-25T14:48:16.838736Z","end":"2026-05-25T14:48:17.202917Z","steps":["trace[553404021] 'process raft request'  (duration: 364.106174ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.203028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.838722Z","time spent":"364.245816ms","remote":"127.0.0.1:49846","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/ingress-nginx/ingress-nginx-leader\" mod_revision:25694 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-25T14:48:17.203041Z","caller":"traceutil/trace.go:171","msg":"trace[269468929] transaction","detail":"{read_only:false; response_revision:25744; number_of_response:1; }","duration":"366.45458ms","start":"2026-05-25T14:48:16.836575Z","end":"2026-05-25T14:48:17.20303Z","steps":["trace[269468929] 'process raft request'  (duration: 366.126614ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.203087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.836545Z","time spent":"366.516172ms","remote":"127.0.0.1:49846","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:25730 > 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-25T14:48:17.203306Z","caller":"traceutil/trace.go:171","msg":"trace[2130281366] transaction","detail":"{read_only:false; response_revision:25746; number_of_response:1; }","duration":"361.851429ms","start":"2026-05-25T14:48:16.841447Z","end":"2026-05-25T14:48:17.203299Z","steps":["trace[2130281366] 'process raft request'  (duration: 361.43591ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.203356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.841438Z","time spent":"361.889939ms","remote":"127.0.0.1:49846","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:25731 > 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-25T14:48:17.203543Z","caller":"traceutil/trace.go:171","msg":"trace[952819652] transaction","detail":"{read_only:false; response_revision:25749; number_of_response:1; }","duration":"352.678525ms","start":"2026-05-25T14:48:16.850853Z","end":"2026-05-25T14:48:17.203532Z","steps":["trace[952819652] 'process raft request'  (duration: 352.565133ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:17.203501Z","caller":"traceutil/trace.go:171","msg":"trace[125518001] transaction","detail":"{read_only:false; response_revision:25747; number_of_response:1; }","duration":"353.614223ms","start":"2026-05-25T14:48:16.849818Z","end":"2026-05-25T14:48:17.203432Z","steps":["trace[125518001] 'process raft request'  (duration: 353.261106ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:17.203604Z","caller":"traceutil/trace.go:171","msg":"trace[1321182135] transaction","detail":"{read_only:false; response_revision:25748; number_of_response:1; }","duration":"352.781237ms","start":"2026-05-25T14:48:16.850794Z","end":"2026-05-25T14:48:17.203575Z","steps":["trace[1321182135] 'process raft request'  (duration: 352.522422ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.203771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.850783Z","time spent":"352.96393ms","remote":"127.0.0.1:49846","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:25733 > 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-25T14:48:17.203608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.850847Z","time spent":"352.723426ms","remote":"127.0.0.1:49846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"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:25734 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-25T14:48:17.203725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.902839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-05-25T14:48:17.203773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.849786Z","time spent":"353.882639ms","remote":"127.0.0.1:49846","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:25732 > 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-25T14:48:17.20384Z","caller":"traceutil/trace.go:171","msg":"trace[676215029] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25749; }","duration":"291.057162ms","start":"2026-05-25T14:48:16.912778Z","end":"2026-05-25T14:48:17.203835Z","steps":["trace[676215029] 'agreement among raft nodes before linearized reading'  (duration: 290.859078ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.203811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.729555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:17.203889Z","caller":"traceutil/trace.go:171","msg":"trace[1019398043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25749; }","duration":"415.899159ms","start":"2026-05-25T14:48:16.787973Z","end":"2026-05-25T14:48:17.203872Z","steps":["trace[1019398043] 'agreement among raft nodes before linearized reading'  (duration: 415.596843ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:17.203922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:16.787947Z","time spent":"415.969671ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-25T14:48:25.837574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.404188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-25T14:48:25.837683Z","caller":"traceutil/trace.go:171","msg":"trace[391711154] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25866; }","duration":"139.608602ms","start":"2026-05-25T14:48:25.698049Z","end":"2026-05-25T14:48:25.837658Z","steps":["trace[391711154] 'count revisions from in-memory index tree'  (duration: 139.262026ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:26.109512Z","caller":"traceutil/trace.go:171","msg":"trace[941302214] linearizableReadLoop","detail":"{readStateIndex:26723; appliedIndex:26722; }","duration":"186.228765ms","start":"2026-05-25T14:48:25.923258Z","end":"2026-05-25T14:48:26.109487Z","steps":["trace[941302214] 'read index received'  (duration: 186.0032ms)","trace[941302214] 'applied index is now lower than readState.Index'  (duration: 225.085µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:26.109723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.447889ms","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-25T14:48:26.109752Z","caller":"traceutil/trace.go:171","msg":"trace[974224615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25867; }","duration":"186.539331ms","start":"2026-05-25T14:48:25.923199Z","end":"2026-05-25T14:48:26.109739Z","steps":["trace[974224615] 'agreement among raft nodes before linearized reading'  (duration: 186.384528ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:26.10975Z","caller":"traceutil/trace.go:171","msg":"trace[1772469814] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"193.135254ms","start":"2026-05-25T14:48:25.916564Z","end":"2026-05-25T14:48:26.109699Z","steps":["trace[1772469814] 'process raft request'  (duration: 192.763586ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:26.307807Z","caller":"traceutil/trace.go:171","msg":"trace[246941253] transaction","detail":"{read_only:false; response_revision:25868; number_of_response:1; }","duration":"193.489511ms","start":"2026-05-25T14:48:26.11426Z","end":"2026-05-25T14:48:26.307749Z","steps":["trace[246941253] 'process raft request'  (duration: 125.195594ms)","trace[246941253] 'compare'  (duration: 67.773706ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:26.432753Z","caller":"traceutil/trace.go:171","msg":"trace[330048439] transaction","detail":"{read_only:false; response_revision:25870; number_of_response:1; }","duration":"118.708794ms","start":"2026-05-25T14:48:26.314003Z","end":"2026-05-25T14:48:26.432712Z","steps":["trace[330048439] 'process raft request'  (duration: 104.99118ms)","trace[330048439] 'compare'  (duration: 13.505339ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:26.697995Z","caller":"traceutil/trace.go:171","msg":"trace[722938472] linearizableReadLoop","detail":"{readStateIndex:26727; appliedIndex:26726; }","duration":"253.375978ms","start":"2026-05-25T14:48:26.444591Z","end":"2026-05-25T14:48:26.697967Z","steps":["trace[722938472] 'read index received'  (duration: 253.149423ms)","trace[722938472] 'applied index is now lower than readState.Index'  (duration: 225.185µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:26.698093Z","caller":"traceutil/trace.go:171","msg":"trace[1647626836] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"256.059401ms","start":"2026-05-25T14:48:26.441978Z","end":"2026-05-25T14:48:26.698037Z","steps":["trace[1647626836] 'process raft request'  (duration: 255.781956ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:26.698329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.707965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"}
{"level":"info","ts":"2026-05-25T14:48:26.698389Z","caller":"traceutil/trace.go:171","msg":"trace[1506527253] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:25871; }","duration":"253.816537ms","start":"2026-05-25T14:48:26.444555Z","end":"2026-05-25T14:48:26.698372Z","steps":["trace[1506527253] 'agreement among raft nodes before linearized reading'  (duration: 253.533421ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:26.920277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.955388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-25T14:48:26.920364Z","caller":"traceutil/trace.go:171","msg":"trace[392002910] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25872; }","duration":"106.107111ms","start":"2026-05-25T14:48:26.814235Z","end":"2026-05-25T14:48:26.920342Z","steps":["trace[392002910] 'range keys from in-memory index tree'  (duration: 105.756515ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:26.920512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.114543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"}
{"level":"info","ts":"2026-05-25T14:48:26.920596Z","caller":"traceutil/trace.go:171","msg":"trace[1249436897] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25872; }","duration":"133.253526ms","start":"2026-05-25T14:48:26.787325Z","end":"2026-05-25T14:48:26.920578Z","steps":["trace[1249436897] 'range keys from in-memory index tree'  (duration: 132.681664ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.057466Z","caller":"traceutil/trace.go:171","msg":"trace[1165929816] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"215.103442ms","start":"2026-05-25T14:48:26.84234Z","end":"2026-05-25T14:48:27.057444Z","steps":["trace[1165929816] 'process raft request'  (duration: 214.940719ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.058011Z","caller":"traceutil/trace.go:171","msg":"trace[2107709525] linearizableReadLoop","detail":"{readStateIndex:26729; appliedIndex:26729; }","duration":"211.778567ms","start":"2026-05-25T14:48:26.846224Z","end":"2026-05-25T14:48:27.058002Z","steps":["trace[2107709525] 'read index received'  (duration: 211.774457ms)","trace[2107709525] 'applied index is now lower than readState.Index'  (duration: 3.56µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:27.058191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.94852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-25T14:48:27.058223Z","caller":"traceutil/trace.go:171","msg":"trace[1643969273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25873; }","duration":"212.050592ms","start":"2026-05-25T14:48:26.846165Z","end":"2026-05-25T14:48:27.058216Z","steps":["trace[1643969273] 'agreement among raft nodes before linearized reading'  (duration: 211.904999ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:27.075449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.860869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18b2d65e90847086\" ","response":"range_response_count:1 size:736"}
{"level":"info","ts":"2026-05-25T14:48:27.075497Z","caller":"traceutil/trace.go:171","msg":"trace[1742585920] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18b2d65e90847086; range_end:; response_count:1; response_revision:25874; }","duration":"188.959601ms","start":"2026-05-25T14:48:26.886524Z","end":"2026-05-25T14:48:27.075483Z","steps":["trace[1742585920] 'agreement among raft nodes before linearized reading'  (duration: 188.826998ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:27.075775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.217945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1446"}
{"level":"info","ts":"2026-05-25T14:48:27.075873Z","caller":"traceutil/trace.go:171","msg":"trace[1462695983] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25874; }","duration":"149.343147ms","start":"2026-05-25T14:48:26.926504Z","end":"2026-05-25T14:48:27.075847Z","steps":["trace[1462695983] 'agreement among raft nodes before linearized reading'  (duration: 149.030511ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.076116Z","caller":"traceutil/trace.go:171","msg":"trace[1648531841] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"149.469981ms","start":"2026-05-25T14:48:26.925973Z","end":"2026-05-25T14:48:27.075443Z","steps":["trace[1648531841] 'process raft request'  (duration: 149.298057ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:27.342781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.04126ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170190752 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18b2d65e9187ecb1\" mod_revision:25851 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18b2d65e9187ecb1\" value_size:652 lease:4089724069315413704 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18b2d65e9187ecb1\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T14:48:27.343151Z","caller":"traceutil/trace.go:171","msg":"trace[1583804863] linearizableReadLoop","detail":"{readStateIndex:26733; appliedIndex:26732; }","duration":"151.771586ms","start":"2026-05-25T14:48:27.191156Z","end":"2026-05-25T14:48:27.342928Z","steps":["trace[1583804863] 'read index received'  (duration: 56.741µs)","trace[1583804863] 'applied index is now lower than readState.Index'  (duration: 151.712755ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:27.34318Z","caller":"traceutil/trace.go:171","msg":"trace[1929330146] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"247.859917ms","start":"2026-05-25T14:48:27.095289Z","end":"2026-05-25T14:48:27.343149Z","steps":["trace[1929330146] 'process raft request'  (duration: 63.324257ms)","trace[1929330146] 'compare'  (duration: 183.814336ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:27.343606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.39062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-25T14:48:27.34372Z","caller":"traceutil/trace.go:171","msg":"trace[908190396] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:25877; }","duration":"152.600543ms","start":"2026-05-25T14:48:27.191093Z","end":"2026-05-25T14:48:27.343693Z","steps":["trace[908190396] 'agreement among raft nodes before linearized reading'  (duration: 152.192454ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.35524Z","caller":"traceutil/trace.go:171","msg":"trace[114292399] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"113.508921ms","start":"2026-05-25T14:48:27.241709Z","end":"2026-05-25T14:48:27.355218Z","steps":["trace[114292399] 'process raft request'  (duration: 112.891919ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.355851Z","caller":"traceutil/trace.go:171","msg":"trace[1524141140] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"112.298226ms","start":"2026-05-25T14:48:27.243539Z","end":"2026-05-25T14:48:27.355837Z","steps":["trace[1524141140] 'process raft request'  (duration: 111.209545ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.355977Z","caller":"traceutil/trace.go:171","msg":"trace[1108492398] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"112.729045ms","start":"2026-05-25T14:48:27.243238Z","end":"2026-05-25T14:48:27.355967Z","steps":["trace[1108492398] 'process raft request'  (duration: 111.48097ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:27.356118Z","caller":"traceutil/trace.go:171","msg":"trace[623222330] transaction","detail":"{read_only:false; response_revision:25881; number_of_response:1; }","duration":"111.565302ms","start":"2026-05-25T14:48:27.24452Z","end":"2026-05-25T14:48:27.356085Z","steps":["trace[623222330] 'process raft request'  (duration: 110.258766ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:32.449313Z","caller":"traceutil/trace.go:171","msg":"trace[1950546203] transaction","detail":"{read_only:false; response_revision:25926; number_of_response:1; }","duration":"151.48883ms","start":"2026-05-25T14:48:32.297793Z","end":"2026-05-25T14:48:32.449281Z","steps":["trace[1950546203] 'process raft request'  (duration: 151.316587ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:32.506694Z","caller":"traceutil/trace.go:171","msg":"trace[420597363] transaction","detail":"{read_only:false; response_revision:25927; number_of_response:1; }","duration":"178.069332ms","start":"2026-05-25T14:48:32.32858Z","end":"2026-05-25T14:48:32.506649Z","steps":["trace[420597363] 'process raft request'  (duration: 161.203855ms)","trace[420597363] 'compare'  (duration: 16.209963ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:32.506712Z","caller":"traceutil/trace.go:171","msg":"trace[2083395875] linearizableReadLoop","detail":"{readStateIndex:26785; appliedIndex:26784; }","duration":"172.643894ms","start":"2026-05-25T14:48:32.333928Z","end":"2026-05-25T14:48:32.506572Z","steps":["trace[2083395875] 'read index received'  (duration: 115.386698ms)","trace[2083395875] 'applied index is now lower than readState.Index'  (duration: 57.255826ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:32.506929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.983ms","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-25T14:48:32.507013Z","caller":"traceutil/trace.go:171","msg":"trace[1488103360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25927; }","duration":"173.125493ms","start":"2026-05-25T14:48:32.333868Z","end":"2026-05-25T14:48:32.506993Z","steps":["trace[1488103360] 'agreement among raft nodes before linearized reading'  (duration: 172.852248ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:32.686392Z","caller":"traceutil/trace.go:171","msg":"trace[286077286] linearizableReadLoop","detail":"{readStateIndex:26786; appliedIndex:26785; }","duration":"179.558852ms","start":"2026-05-25T14:48:32.5068Z","end":"2026-05-25T14:48:32.686359Z","steps":["trace[286077286] 'read index received'  (duration: 179.44711ms)","trace[286077286] 'applied index is now lower than readState.Index'  (duration: 110.202µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:32.686434Z","caller":"traceutil/trace.go:171","msg":"trace[35150257] transaction","detail":"{read_only:false; response_revision:25928; number_of_response:1; }","duration":"231.91995ms","start":"2026-05-25T14:48:32.45448Z","end":"2026-05-25T14:48:32.6864Z","steps":["trace[35150257] 'process raft request'  (duration: 231.707206ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:32.686722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.700835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-25T14:48:32.686775Z","caller":"traceutil/trace.go:171","msg":"trace[108510067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25928; }","duration":"228.773317ms","start":"2026-05-25T14:48:32.457987Z","end":"2026-05-25T14:48:32.68676Z","steps":["trace[108510067] 'agreement among raft nodes before linearized reading'  (duration: 228.524462ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:32.686804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.96926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:9192"}
{"level":"info","ts":"2026-05-25T14:48:32.686924Z","caller":"traceutil/trace.go:171","msg":"trace[1649938387] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25928; }","duration":"213.117503ms","start":"2026-05-25T14:48:32.47378Z","end":"2026-05-25T14:48:32.686898Z","steps":["trace[1649938387] 'agreement among raft nodes before linearized reading'  (duration: 212.709125ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:32.717841Z","caller":"traceutil/trace.go:171","msg":"trace[346820134] transaction","detail":"{read_only:false; response_revision:25929; number_of_response:1; }","duration":"206.221535ms","start":"2026-05-25T14:48:32.511555Z","end":"2026-05-25T14:48:32.717777Z","steps":["trace[346820134] 'process raft request'  (duration: 205.95553ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:32.75824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.482799ms","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":"info","ts":"2026-05-25T14:48:32.758317Z","caller":"traceutil/trace.go:171","msg":"trace[70546864] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25929; }","duration":"205.615712ms","start":"2026-05-25T14:48:32.552683Z","end":"2026-05-25T14:48:32.758298Z","steps":["trace[70546864] 'agreement among raft nodes before linearized reading'  (duration: 205.432048ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:32.758487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.592573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-25T14:48:32.758526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.417269ms","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-25T14:48:32.758533Z","caller":"traceutil/trace.go:171","msg":"trace[1387825106] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:25929; }","duration":"148.657034ms","start":"2026-05-25T14:48:32.609864Z","end":"2026-05-25T14:48:32.758521Z","steps":["trace[1387825106] 'agreement among raft nodes before linearized reading'  (duration: 148.573803ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:32.75856Z","caller":"traceutil/trace.go:171","msg":"trace[867605130] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25929; }","duration":"197.46553ms","start":"2026-05-25T14:48:32.561082Z","end":"2026-05-25T14:48:32.758548Z","steps":["trace[867605130] 'agreement among raft nodes before linearized reading'  (duration: 197.367018ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:34.618702Z","caller":"traceutil/trace.go:171","msg":"trace[1544442144] linearizableReadLoop","detail":"{readStateIndex:26807; appliedIndex:26806; }","duration":"103.266806ms","start":"2026-05-25T14:48:34.515391Z","end":"2026-05-25T14:48:34.618658Z","steps":["trace[1544442144] 'read index received'  (duration: 102.9964ms)","trace[1544442144] 'applied index is now lower than readState.Index'  (duration: 268.056µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:34.618781Z","caller":"traceutil/trace.go:171","msg":"trace[2142026121] transaction","detail":"{read_only:false; response_revision:25948; number_of_response:1; }","duration":"105.98417ms","start":"2026-05-25T14:48:34.512732Z","end":"2026-05-25T14:48:34.618716Z","steps":["trace[2142026121] 'process raft request'  (duration: 105.645242ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:34.618945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.526861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10358"}
{"level":"info","ts":"2026-05-25T14:48:34.619043Z","caller":"traceutil/trace.go:171","msg":"trace[872827732] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25948; }","duration":"103.692144ms","start":"2026-05-25T14:48:34.515333Z","end":"2026-05-25T14:48:34.619025Z","steps":["trace[872827732] 'agreement among raft nodes before linearized reading'  (duration: 103.444039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:34.619195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.915719ms","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":"info","ts":"2026-05-25T14:48:34.619304Z","caller":"traceutil/trace.go:171","msg":"trace[1613009632] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25948; }","duration":"102.068402ms","start":"2026-05-25T14:48:34.517209Z","end":"2026-05-25T14:48:34.619277Z","steps":["trace[1613009632] 'agreement among raft nodes before linearized reading'  (duration: 101.766606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:39.624286Z","caller":"traceutil/trace.go:171","msg":"trace[687715023] linearizableReadLoop","detail":"{readStateIndex:26860; appliedIndex:26855; }","duration":"210.950759ms","start":"2026-05-25T14:48:39.413313Z","end":"2026-05-25T14:48:39.624264Z","steps":["trace[687715023] 'read index received'  (duration: 55.820957ms)","trace[687715023] 'applied index is now lower than readState.Index'  (duration: 155.128672ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:39.624374Z","caller":"traceutil/trace.go:171","msg":"trace[2108881744] transaction","detail":"{read_only:false; response_revision:25998; number_of_response:1; }","duration":"217.808096ms","start":"2026-05-25T14:48:39.406537Z","end":"2026-05-25T14:48:39.624346Z","steps":["trace[2108881744] 'process raft request'  (duration: 217.53204ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:39.624476Z","caller":"traceutil/trace.go:171","msg":"trace[684200218] transaction","detail":"{read_only:false; response_revision:26000; number_of_response:1; }","duration":"217.697904ms","start":"2026-05-25T14:48:39.406726Z","end":"2026-05-25T14:48:39.624424Z","steps":["trace[684200218] 'process raft request'  (duration: 217.47063ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:39.624547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.217414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-25T14:48:39.624519Z","caller":"traceutil/trace.go:171","msg":"trace[1970485357] transaction","detail":"{read_only:false; response_revision:25999; number_of_response:1; }","duration":"217.831316ms","start":"2026-05-25T14:48:39.40663Z","end":"2026-05-25T14:48:39.624462Z","steps":["trace[1970485357] 'process raft request'  (duration: 217.52959ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:39.624589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.821377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-25T14:48:39.62463Z","caller":"traceutil/trace.go:171","msg":"trace[905379245] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:26000; }","duration":"115.932549ms","start":"2026-05-25T14:48:39.508688Z","end":"2026-05-25T14:48:39.624621Z","steps":["trace[905379245] 'agreement among raft nodes before linearized reading'  (duration: 115.801355ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:39.624195Z","caller":"traceutil/trace.go:171","msg":"trace[1664680193] transaction","detail":"{read_only:false; response_revision:25997; number_of_response:1; }","duration":"220.672493ms","start":"2026-05-25T14:48:39.403495Z","end":"2026-05-25T14:48:39.624168Z","steps":["trace[1664680193] 'process raft request'  (duration: 165.845887ms)","trace[1664680193] 'compare'  (duration: 54.447769ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:39.624584Z","caller":"traceutil/trace.go:171","msg":"trace[94497392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26000; }","duration":"211.296156ms","start":"2026-05-25T14:48:39.413269Z","end":"2026-05-25T14:48:39.624565Z","steps":["trace[94497392] 'agreement among raft nodes before linearized reading'  (duration: 211.128713ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:49.433668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.890219ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170191208 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26055 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T14:48:49.43393Z","caller":"traceutil/trace.go:171","msg":"trace[998845754] linearizableReadLoop","detail":"{readStateIndex:26932; appliedIndex:26930; }","duration":"122.609773ms","start":"2026-05-25T14:48:49.311295Z","end":"2026-05-25T14:48:49.433905Z","steps":["trace[998845754] 'read index received'  (duration: 13.062572ms)","trace[998845754] 'applied index is now lower than readState.Index'  (duration: 109.544891ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:49.433941Z","caller":"traceutil/trace.go:171","msg":"trace[2100243749] transaction","detail":"{read_only:false; response_revision:26069; number_of_response:1; }","duration":"184.799786ms","start":"2026-05-25T14:48:49.2491Z","end":"2026-05-25T14:48:49.4339Z","steps":["trace[2100243749] 'process raft request'  (duration: 59.535181ms)","trace[2100243749] 'compare'  (duration: 124.670584ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:49.434018Z","caller":"traceutil/trace.go:171","msg":"trace[675231703] transaction","detail":"{read_only:false; response_revision:26070; number_of_response:1; }","duration":"184.290567ms","start":"2026-05-25T14:48:49.249687Z","end":"2026-05-25T14:48:49.433977Z","steps":["trace[675231703] 'process raft request'  (duration: 184.124004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:49.434084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.782247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:48:49.434136Z","caller":"traceutil/trace.go:171","msg":"trace[2046360548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26070; }","duration":"122.860368ms","start":"2026-05-25T14:48:49.311259Z","end":"2026-05-25T14:48:49.434119Z","steps":["trace[2046360548] 'agreement among raft nodes before linearized reading'  (duration: 122.727535ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:51.590515Z","caller":"traceutil/trace.go:171","msg":"trace[121476669] transaction","detail":"{read_only:false; response_revision:26084; number_of_response:1; }","duration":"147.094353ms","start":"2026-05-25T14:48:51.443402Z","end":"2026-05-25T14:48:51.590496Z","steps":["trace[121476669] 'process raft request'  (duration: 146.955ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:51.799755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.178825ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096106170191241 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26070 > 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-25T14:48:51.79998Z","caller":"traceutil/trace.go:171","msg":"trace[197668067] transaction","detail":"{read_only:false; response_revision:26086; number_of_response:1; }","duration":"235.613033ms","start":"2026-05-25T14:48:51.564347Z","end":"2026-05-25T14:48:51.79996Z","steps":["trace[197668067] 'process raft request'  (duration: 235.533522ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:51.800124Z","caller":"traceutil/trace.go:171","msg":"trace[1594729974] transaction","detail":"{read_only:false; response_revision:26085; number_of_response:1; }","duration":"355.626094ms","start":"2026-05-25T14:48:51.44446Z","end":"2026-05-25T14:48:51.800086Z","steps":["trace[1594729974] 'process raft request'  (duration: 223.02064ms)","trace[1594729974] 'compare'  (duration: 131.983642ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:48:51.800304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:48:51.444441Z","time spent":"355.769106ms","remote":"127.0.0.1:49846","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:26070 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-25T14:48:53.339262Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000695c.wal"}
{"level":"info","ts":"2026-05-25T14:48:56.057673Z","caller":"traceutil/trace.go:171","msg":"trace[1370863290] transaction","detail":"{read_only:false; response_revision:26127; number_of_response:1; }","duration":"242.899709ms","start":"2026-05-25T14:48:55.814742Z","end":"2026-05-25T14:48:56.057642Z","steps":["trace[1370863290] 'process raft request'  (duration: 242.635842ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:56.057965Z","caller":"traceutil/trace.go:171","msg":"trace[1142077871] transaction","detail":"{read_only:false; response_revision:26128; number_of_response:1; }","duration":"234.43741ms","start":"2026-05-25T14:48:55.82352Z","end":"2026-05-25T14:48:56.057958Z","steps":["trace[1142077871] 'process raft request'  (duration: 234.037782ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:56.058125Z","caller":"traceutil/trace.go:171","msg":"trace[1651987497] linearizableReadLoop","detail":"{readStateIndex:26991; appliedIndex:26989; }","duration":"239.46404ms","start":"2026-05-25T14:48:55.818651Z","end":"2026-05-25T14:48:56.058115Z","steps":["trace[1651987497] 'read index received'  (duration: 24.953289ms)","trace[1651987497] 'applied index is now lower than readState.Index'  (duration: 214.509901ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:56.058165Z","caller":"traceutil/trace.go:171","msg":"trace[1620860945] transaction","detail":"{read_only:false; response_revision:26129; number_of_response:1; }","duration":"234.43369ms","start":"2026-05-25T14:48:55.823724Z","end":"2026-05-25T14:48:56.058158Z","steps":["trace[1620860945] 'process raft request'  (duration: 233.870579ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:56.058783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.019381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-25T14:48:56.058821Z","caller":"traceutil/trace.go:171","msg":"trace[126935317] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26130; }","duration":"229.082913ms","start":"2026-05-25T14:48:55.829726Z","end":"2026-05-25T14:48:56.058809Z","steps":["trace[126935317] 'agreement among raft nodes before linearized reading'  (duration: 228.997531ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:56.058363Z","caller":"traceutil/trace.go:171","msg":"trace[423962048] transaction","detail":"{read_only:false; response_revision:26130; number_of_response:1; }","duration":"233.692525ms","start":"2026-05-25T14:48:55.824641Z","end":"2026-05-25T14:48:56.058334Z","steps":["trace[423962048] 'process raft request'  (duration: 233.266927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:48:56.058583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.961611ms","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-25T14:48:56.059211Z","caller":"traceutil/trace.go:171","msg":"trace[826357772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26130; }","duration":"240.634183ms","start":"2026-05-25T14:48:55.818569Z","end":"2026-05-25T14:48:56.059203Z","steps":["trace[826357772] 'agreement among raft nodes before linearized reading'  (duration: 239.852218ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:48:56.165512Z","caller":"traceutil/trace.go:171","msg":"trace[1293488543] transaction","detail":"{read_only:false; response_revision:26131; number_of_response:1; }","duration":"101.191014ms","start":"2026-05-25T14:48:56.064288Z","end":"2026-05-25T14:48:56.165479Z","steps":["trace[1293488543] 'process raft request'  (duration: 64.882108ms)","trace[1293488543] 'compare'  (duration: 36.041901ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:48:56.165714Z","caller":"traceutil/trace.go:171","msg":"trace[1171814311] transaction","detail":"{read_only:false; response_revision:26132; number_of_response:1; }","duration":"100.868488ms","start":"2026-05-25T14:48:56.064797Z","end":"2026-05-25T14:48:56.165665Z","steps":["trace[1171814311] 'process raft request'  (duration: 100.625503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:02.343372Z","caller":"traceutil/trace.go:171","msg":"trace[1002273756] linearizableReadLoop","detail":"{readStateIndex:27039; appliedIndex:27038; }","duration":"144.738274ms","start":"2026-05-25T14:49:02.198601Z","end":"2026-05-25T14:49:02.343339Z","steps":["trace[1002273756] 'read index received'  (duration: 144.631502ms)","trace[1002273756] 'applied index is now lower than readState.Index'  (duration: 105.242µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:49:02.343527Z","caller":"traceutil/trace.go:171","msg":"trace[631056677] transaction","detail":"{read_only:false; response_revision:26174; number_of_response:1; }","duration":"149.082231ms","start":"2026-05-25T14:49:02.194397Z","end":"2026-05-25T14:49:02.343479Z","steps":["trace[631056677] 'process raft request'  (duration: 148.749275ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:02.343729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.105442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-25T14:49:02.343828Z","caller":"traceutil/trace.go:171","msg":"trace[1324972349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26174; }","duration":"145.218225ms","start":"2026-05-25T14:49:02.19859Z","end":"2026-05-25T14:49:02.343809Z","steps":["trace[1324972349] 'agreement among raft nodes before linearized reading'  (duration: 144.900067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:02.461117Z","caller":"traceutil/trace.go:171","msg":"trace[1959709520] transaction","detail":"{read_only:false; response_revision:26175; number_of_response:1; }","duration":"212.815377ms","start":"2026-05-25T14:49:02.248257Z","end":"2026-05-25T14:49:02.461072Z","steps":["trace[1959709520] 'process raft request'  (duration: 211.359058ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:02.461197Z","caller":"traceutil/trace.go:171","msg":"trace[928462023] transaction","detail":"{read_only:false; response_revision:26177; number_of_response:1; }","duration":"113.040851ms","start":"2026-05-25T14:49:02.348135Z","end":"2026-05-25T14:49:02.461175Z","steps":["trace[928462023] 'process raft request'  (duration: 112.973299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:02.46125Z","caller":"traceutil/trace.go:171","msg":"trace[830125494] transaction","detail":"{read_only:false; response_revision:26176; number_of_response:1; }","duration":"120.404738ms","start":"2026-05-25T14:49:02.340795Z","end":"2026-05-25T14:49:02.4612Z","steps":["trace[830125494] 'process raft request'  (duration: 120.177994ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:02.461295Z","caller":"traceutil/trace.go:171","msg":"trace[1068560875] linearizableReadLoop","detail":"{readStateIndex:27041; appliedIndex:27039; }","duration":"117.763886ms","start":"2026-05-25T14:49:02.343498Z","end":"2026-05-25T14:49:02.461262Z","steps":["trace[1068560875] 'read index received'  (duration: 116.133503ms)","trace[1068560875] 'applied index is now lower than readState.Index'  (duration: 1.628122ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:49:02.461553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.033471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:49:02.461647Z","caller":"traceutil/trace.go:171","msg":"trace[1526453593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26177; }","duration":"151.191025ms","start":"2026-05-25T14:49:02.310435Z","end":"2026-05-25T14:49:02.461626Z","steps":["trace[1526453593] 'agreement among raft nodes before linearized reading'  (duration: 150.94323ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:06.283788Z","caller":"traceutil/trace.go:171","msg":"trace[1954288717] transaction","detail":"{read_only:false; response_revision:26201; number_of_response:1; }","duration":"179.930829ms","start":"2026-05-25T14:49:06.103826Z","end":"2026-05-25T14:49:06.283757Z","steps":["trace[1954288717] 'process raft request'  (duration: 179.710345ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:06.427068Z","caller":"traceutil/trace.go:171","msg":"trace[1649312515] transaction","detail":"{read_only:false; response_revision:26202; number_of_response:1; }","duration":"321.767646ms","start":"2026-05-25T14:49:06.105271Z","end":"2026-05-25T14:49:06.427039Z","steps":["trace[1649312515] 'process raft request'  (duration: 230.487241ms)","trace[1649312515] 'compare'  (duration: 90.697924ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T14:49:06.427257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:49:06.105259Z","time spent":"321.894399ms","remote":"127.0.0.1:49846","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:26188 > 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-25T14:49:06.427657Z","caller":"traceutil/trace.go:171","msg":"trace[1548108378] transaction","detail":"{read_only:false; response_revision:26203; number_of_response:1; }","duration":"321.925069ms","start":"2026-05-25T14:49:06.105697Z","end":"2026-05-25T14:49:06.427622Z","steps":["trace[1548108378] 'process raft request'  (duration: 321.276557ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:06.427778Z","caller":"traceutil/trace.go:171","msg":"trace[985135127] linearizableReadLoop","detail":"{readStateIndex:27070; appliedIndex:27066; }","duration":"214.133952ms","start":"2026-05-25T14:49:06.213629Z","end":"2026-05-25T14:49:06.427763Z","steps":["trace[985135127] 'read index received'  (duration: 69.883017ms)","trace[985135127] 'applied index is now lower than readState.Index'  (duration: 144.249545ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:49:06.42799Z","caller":"traceutil/trace.go:171","msg":"trace[1012145127] transaction","detail":"{read_only:false; response_revision:26204; number_of_response:1; }","duration":"321.679593ms","start":"2026-05-25T14:49:06.1063Z","end":"2026-05-25T14:49:06.427979Z","steps":["trace[1012145127] 'process raft request'  (duration: 321.155543ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:06.428292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.642704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:49:06.428409Z","caller":"traceutil/trace.go:171","msg":"trace[343105318] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:26204; }","duration":"214.814347ms","start":"2026-05-25T14:49:06.213577Z","end":"2026-05-25T14:49:06.428392Z","steps":["trace[343105318] 'agreement among raft nodes before linearized reading'  (duration: 214.633783ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:06.428522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:49:06.106286Z","time spent":"321.735744ms","remote":"127.0.0.1:49846","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:26189 > 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-25T14:49:06.428872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:49:06.10566Z","time spent":"322.098983ms","remote":"127.0.0.1:49846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26187 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-25T14:49:06.680015Z","caller":"traceutil/trace.go:171","msg":"trace[305313106] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"242.083751ms","start":"2026-05-25T14:49:06.437902Z","end":"2026-05-25T14:49:06.679985Z","steps":["trace[305313106] 'process raft request'  (duration: 179.963389ms)","trace[305313106] 'compare'  (duration: 61.98779ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:49:06.710902Z","caller":"traceutil/trace.go:171","msg":"trace[970128958] linearizableReadLoop","detail":"{readStateIndex:27072; appliedIndex:27070; }","duration":"234.534051ms","start":"2026-05-25T14:49:06.47633Z","end":"2026-05-25T14:49:06.710864Z","steps":["trace[970128958] 'read index received'  (duration: 141.573342ms)","trace[970128958] 'applied index is now lower than readState.Index'  (duration: 92.958759ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:49:06.711035Z","caller":"traceutil/trace.go:171","msg":"trace[1432487270] transaction","detail":"{read_only:false; response_revision:26206; number_of_response:1; }","duration":"235.757156ms","start":"2026-05-25T14:49:06.475184Z","end":"2026-05-25T14:49:06.710941Z","steps":["trace[1432487270] 'process raft request'  (duration: 235.46189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:06.711164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.816648ms","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-25T14:49:06.71123Z","caller":"traceutil/trace.go:171","msg":"trace[2092194664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26206; }","duration":"234.929779ms","start":"2026-05-25T14:49:06.476285Z","end":"2026-05-25T14:49:06.711215Z","steps":["trace[2092194664] 'agreement among raft nodes before linearized reading'  (duration: 234.718075ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:49:07.213355Z","caller":"traceutil/trace.go:171","msg":"trace[1348610922] transaction","detail":"{read_only:false; response_revision:26210; number_of_response:1; }","duration":"142.184974ms","start":"2026-05-25T14:49:07.071138Z","end":"2026-05-25T14:49:07.213323Z","steps":["trace[1348610922] 'process raft request'  (duration: 64.119973ms)","trace[1348610922] 'compare'  (duration: 77.706824ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T14:49:11.510163Z","caller":"traceutil/trace.go:171","msg":"trace[453188431] transaction","detail":"{read_only:false; response_revision:26252; number_of_response:1; }","duration":"109.391149ms","start":"2026-05-25T14:49:11.400731Z","end":"2026-05-25T14:49:11.510122Z","steps":["trace[453188431] 'process raft request'  (duration: 109.061932ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:11.71227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.213885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:49:11.712413Z","caller":"traceutil/trace.go:171","msg":"trace[1691922378] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:26252; }","duration":"139.398008ms","start":"2026-05-25T14:49:11.572986Z","end":"2026-05-25T14:49:11.712384Z","steps":["trace[1691922378] 'count revisions from in-memory index tree'  (duration: 139.133754ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:11.712596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.43449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T14:49:11.712667Z","caller":"traceutil/trace.go:171","msg":"trace[936990926] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:26252; }","duration":"130.588942ms","start":"2026-05-25T14:49:11.582061Z","end":"2026-05-25T14:49:11.71265Z","steps":["trace[936990926] 'count revisions from in-memory index tree'  (duration: 130.297997ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T14:49:11.712795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.773975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-25T14:49:11.712893Z","caller":"traceutil/trace.go:171","msg":"trace[2117260683] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:26252; }","duration":"120.921089ms","start":"2026-05-25T14:49:11.59195Z","end":"2026-05-25T14:49:11.712871Z","steps":["trace[2117260683] 'count revisions from in-memory index tree'  (duration: 120.697814ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:52:14.042251Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25135}
{"level":"info","ts":"2026-05-25T14:52:14.201919Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25135,"took":"152.269535ms","hash":3646827664,"current-db-size-bytes":59387904,"current-db-size":"59 MB","current-db-size-in-use-bytes":36962304,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-05-25T14:52:14.201992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3646827664,"revision":25135,"compact-revision":21927}
{"level":"info","ts":"2026-05-25T14:53:16.229448Z","caller":"traceutil/trace.go:171","msg":"trace[777098037] transaction","detail":"{read_only:false; response_revision:28704; number_of_response:1; }","duration":"143.545821ms","start":"2026-05-25T14:53:16.085867Z","end":"2026-05-25T14:53:16.229413Z","steps":["trace[777098037] 'process raft request'  (duration: 143.352517ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:53:16.234664Z","caller":"traceutil/trace.go:171","msg":"trace[1088238882] transaction","detail":"{read_only:false; response_revision:28705; number_of_response:1; }","duration":"148.603002ms","start":"2026-05-25T14:53:16.086023Z","end":"2026-05-25T14:53:16.234626Z","steps":["trace[1088238882] 'process raft request'  (duration: 148.453469ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T14:54:02.795149Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T14:54:02.801616Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-25T14:54:02.80182Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-25T14:57:14.050802Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28037}
{"level":"info","ts":"2026-05-25T14:57:14.190731Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28037,"took":"134.923336ms","hash":1147171515,"current-db-size-bytes":59387904,"current-db-size":"59 MB","current-db-size-in-use-bytes":32710656,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-25T14:57:14.190803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1147171515,"revision":28037,"compact-revision":25135}
{"level":"info","ts":"2026-05-25T15:02:14.058107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30497}
{"level":"info","ts":"2026-05-25T15:02:14.197363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30497,"took":"132.577237ms","hash":3049741339,"current-db-size-bytes":59387904,"current-db-size":"59 MB","current-db-size-in-use-bytes":30539776,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-25T15:02:14.197442Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3049741339,"revision":30497,"compact-revision":28037}
{"level":"info","ts":"2026-05-25T15:07:14.065005Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32818}
{"level":"info","ts":"2026-05-25T15:07:14.215732Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32818,"took":"145.676782ms","hash":3096533730,"current-db-size-bytes":59387904,"current-db-size":"59 MB","current-db-size-in-use-bytes":30113792,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-25T15:07:14.215811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3096533730,"revision":32818,"compact-revision":30497}
{"level":"info","ts":"2026-05-25T15:12:14.071092Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35079}
{"level":"info","ts":"2026-05-25T15:12:14.217797Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35079,"took":"141.088703ms","hash":2106621578,"current-db-size-bytes":59387904,"current-db-size":"59 MB","current-db-size-in-use-bytes":31789056,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-25T15:12:14.217883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2106621578,"revision":35079,"compact-revision":32818}
{"level":"info","ts":"2026-05-25T15:15:15.677983Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T15:15:15.683456Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-25T15:15:15.683555Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-25T15:17:14.078462Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37376}
{"level":"info","ts":"2026-05-25T15:17:14.204035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37376,"took":"119.736525ms","hash":4084557311,"current-db-size-bytes":61087744,"current-db-size":"61 MB","current-db-size-in-use-bytes":32178176,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-25T15:17:14.204133Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4084557311,"revision":37376,"compact-revision":35079}