{"level":"warn","ts":"2026-05-04T11:28:45.078478Z","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-04T11:28:45.078668Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-04T11:28:45.078777Z","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-04T11:28:45.078794Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]}
{"level":"info","ts":"2026-05-04T11:28:45.078818Z","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-04T11:28:45.079664Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]}
{"level":"info","ts":"2026-05-04T11:28:45.079763Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-04T11:28:45.085118Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.03171ms"}
{"level":"info","ts":"2026-05-04T11:28:45.094623Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"}
{"level":"info","ts":"2026-05-04T11:28:45.094773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-04T11:28:45.094957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"}
{"level":"info","ts":"2026-05-04T11:28:45.094986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-04T11:28:45.095002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"}
{"level":"info","ts":"2026-05-04T11:28:45.09514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"}
{"level":"warn","ts":"2026-05-04T11:28:45.100549Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-04T11:28:45.102832Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-04T11:28:45.105081Z","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-04T11:28:45.107177Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-04T11:28:45.107398Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-04T11:28:45.107719Z","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-04T11:28:45.107844Z","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-04T11:28:45.10786Z","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-04T11:28:45.112352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"}
{"level":"info","ts":"2026-05-04T11:28:45.11274Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]}
{"level":"info","ts":"2026-05-04T11:28:45.115153Z","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-04T11:28:45.115295Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"}
{"level":"info","ts":"2026-05-04T11:28:45.115392Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"}
{"level":"info","ts":"2026-05-04T11:28:45.115577Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-04T11:28:45.115618Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-04T11:28:45.795886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-04T11:28:45.795967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-04T11:28:45.796017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"}
{"level":"info","ts":"2026-05-04T11:28:45.796039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"}
{"level":"info","ts":"2026-05-04T11:28:45.796051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"}
{"level":"info","ts":"2026-05-04T11:28:45.796067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"}
{"level":"info","ts":"2026-05-04T11:28:45.796081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"}
{"level":"info","ts":"2026-05-04T11:28:45.799458Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T11:28:45.801972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T11:28:45.801885Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-04T11:28:45.802036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T11:28:45.802468Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-04T11:28:45.802567Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-04T11:28:45.804594Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T11:28:45.80476Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T11:28:45.804833Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T11:28:45.806097Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"}
{"level":"info","ts":"2026-05-04T11:28:45.806737Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-04T11:28:59.206969Z","caller":"traceutil/trace.go:171","msg":"trace[952421926] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"124.712795ms","start":"2026-05-04T11:28:59.082225Z","end":"2026-05-04T11:28:59.206938Z","steps":["trace[952421926] 'process raft request'  (duration: 124.52809ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:28:59.529474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.693136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T11:28:59.529608Z","caller":"traceutil/trace.go:171","msg":"trace[1493150033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:403; }","duration":"239.89905ms","start":"2026-05-04T11:28:59.289688Z","end":"2026-05-04T11:28:59.529587Z","steps":["trace[1493150033] 'range keys from in-memory index tree'  (duration: 239.600253ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:28:59.529475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.971001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T11:28:59.529722Z","caller":"traceutil/trace.go:171","msg":"trace[877280467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:403; }","duration":"240.301788ms","start":"2026-05-04T11:28:59.289405Z","end":"2026-05-04T11:28:59.529707Z","steps":["trace[877280467] 'range keys from in-memory index tree'  (duration: 239.851099ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:28:59.694913Z","caller":"traceutil/trace.go:171","msg":"trace[2107843746] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"161.459156ms","start":"2026-05-04T11:28:59.533417Z","end":"2026-05-04T11:28:59.694876Z","steps":["trace[2107843746] 'process raft request'  (duration: 161.280403ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:28:59.828345Z","caller":"traceutil/trace.go:171","msg":"trace[1626209292] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"294.317651ms","start":"2026-05-04T11:28:59.533996Z","end":"2026-05-04T11:28:59.828314Z","steps":["trace[1626209292] 'process raft request'  (duration: 276.869518ms)","trace[1626209292] 'compare'  (duration: 17.32213ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:29:28.230356Z","caller":"traceutil/trace.go:171","msg":"trace[496942177] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"246.377015ms","start":"2026-05-04T11:29:27.983947Z","end":"2026-05-04T11:29:28.230324Z","steps":["trace[496942177] 'read index received'  (duration: 246.080169ms)","trace[496942177] 'applied index is now lower than readState.Index'  (duration: 295.476µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:29:28.230452Z","caller":"traceutil/trace.go:171","msg":"trace[223480080] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"247.424426ms","start":"2026-05-04T11:29:27.982984Z","end":"2026-05-04T11:29:28.230409Z","steps":["trace[223480080] 'process raft request'  (duration: 247.042588ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:29:28.230609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.62435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"}
{"level":"info","ts":"2026-05-04T11:29:28.230671Z","caller":"traceutil/trace.go:171","msg":"trace[1164492044] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:614; }","duration":"246.725082ms","start":"2026-05-04T11:29:27.98393Z","end":"2026-05-04T11:29:28.230655Z","steps":["trace[1164492044] 'agreement among raft nodes before linearized reading'  (duration: 246.521348ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:29:28.23473Z","caller":"traceutil/trace.go:171","msg":"trace[1600512845] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"202.74124ms","start":"2026-05-04T11:29:28.031968Z","end":"2026-05-04T11:29:28.234709Z","steps":["trace[1600512845] 'process raft request'  (duration: 202.668138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:29:28.23478Z","caller":"traceutil/trace.go:171","msg":"trace[207225300] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"250.578758ms","start":"2026-05-04T11:29:27.984145Z","end":"2026-05-04T11:29:28.234723Z","steps":["trace[207225300] 'process raft request'  (duration: 250.341833ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:29:33.407858Z","caller":"traceutil/trace.go:171","msg":"trace[484880756] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"354.912515ms","start":"2026-05-04T11:29:33.052913Z","end":"2026-05-04T11:29:33.407825Z","steps":["trace[484880756] 'read index received'  (duration: 353.853095ms)","trace[484880756] 'applied index is now lower than readState.Index'  (duration: 1.05834ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:29:33.408047Z","caller":"traceutil/trace.go:171","msg":"trace[1312687351] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"453.088453ms","start":"2026-05-04T11:29:32.954869Z","end":"2026-05-04T11:29:33.407958Z","steps":["trace[1312687351] 'process raft request'  (duration: 452.317757ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:29:33.408049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.112515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T11:29:33.408167Z","caller":"traceutil/trace.go:171","msg":"trace[333576387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"288.309669ms","start":"2026-05-04T11:29:33.119846Z","end":"2026-05-04T11:29:33.408155Z","steps":["trace[333576387] 'agreement among raft nodes before linearized reading'  (duration: 288.145815ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:29:33.408221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.294603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lvvq2\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-04T11:29:33.408338Z","caller":"traceutil/trace.go:171","msg":"trace[1873484516] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lvvq2; range_end:; response_count:1; response_revision:646; }","duration":"355.465956ms","start":"2026-05-04T11:29:33.052837Z","end":"2026-05-04T11:29:33.408303Z","steps":["trace[1873484516] 'agreement among raft nodes before linearized reading'  (duration: 355.14249ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:29:33.408453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T11:29:33.052807Z","time spent":"355.63213ms","remote":"127.0.0.1:37138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-lvvq2\" "}
{"level":"warn","ts":"2026-05-04T11:29:33.409018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T11:29:32.954827Z","time spent":"453.361818ms","remote":"127.0.0.1:37070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:642 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036193 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-04T11:29:49.143279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.763175ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507580309 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:21c29df2bf6e2d94>","response":"size:40"}
{"level":"info","ts":"2026-05-04T11:29:49.143434Z","caller":"traceutil/trace.go:171","msg":"trace[1687442115] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"189.968059ms","start":"2026-05-04T11:29:48.95344Z","end":"2026-05-04T11:29:49.143408Z","steps":["trace[1687442115] 'read index received'  (duration: 28.746665ms)","trace[1687442115] 'applied index is now lower than readState.Index'  (duration: 161.219194ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T11:29:49.14363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.143963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T11:29:49.143768Z","caller":"traceutil/trace.go:171","msg":"trace[950509793] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:811; }","duration":"190.365017ms","start":"2026-05-04T11:29:48.953372Z","end":"2026-05-04T11:29:49.143737Z","steps":["trace[950509793] 'agreement among raft nodes before linearized reading'  (duration: 190.097592ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:30:33.14588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.180526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-04T11:30:33.146018Z","caller":"traceutil/trace.go:171","msg":"trace[558827778] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1342; }","duration":"101.40115ms","start":"2026-05-04T11:30:33.044596Z","end":"2026-05-04T11:30:33.145997Z","steps":["trace[558827778] 'range keys from in-memory index tree'  (duration: 100.944061ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:30:40.821503Z","caller":"traceutil/trace.go:171","msg":"trace[1773937260] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"130.140744ms","start":"2026-05-04T11:30:40.691329Z","end":"2026-05-04T11:30:40.82147Z","steps":["trace[1773937260] 'process raft request'  (duration: 85.451688ms)","trace[1773937260] 'compare'  (duration: 44.569734ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T11:31:03.562414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.530696ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507582426 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1801 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T11:31:03.562502Z","caller":"traceutil/trace.go:171","msg":"trace[1587315547] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"256.894821ms","start":"2026-05-04T11:31:03.305593Z","end":"2026-05-04T11:31:03.562488Z","steps":["trace[1587315547] 'process raft request'  (duration: 31.208782ms)","trace[1587315547] 'compare'  (duration: 225.440295ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:31:03.91612Z","caller":"traceutil/trace.go:171","msg":"trace[559906047] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"345.921629ms","start":"2026-05-04T11:31:03.570159Z","end":"2026-05-04T11:31:03.91608Z","steps":["trace[559906047] 'process raft request'  (duration: 345.706215ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:31:03.916356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T11:31:03.570143Z","time spent":"346.088932ms","remote":"127.0.0.1:37138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85f486c2-809e-4502-91ef-a9b732d6857d\" mod_revision:1834 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85f486c2-809e-4502-91ef-a9b732d6857d\" value_size:3629 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85f486c2-809e-4502-91ef-a9b732d6857d\" > >"}
{"level":"info","ts":"2026-05-04T11:31:03.937229Z","caller":"traceutil/trace.go:171","msg":"trace[560910433] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1942; }","duration":"174.655298ms","start":"2026-05-04T11:31:03.762554Z","end":"2026-05-04T11:31:03.937209Z","steps":["trace[560910433] 'read index received'  (duration: 153.394951ms)","trace[560910433] 'applied index is now lower than readState.Index'  (duration: 21.259017ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:31:03.93737Z","caller":"traceutil/trace.go:171","msg":"trace[3767339] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"270.805094ms","start":"2026-05-04T11:31:03.666507Z","end":"2026-05-04T11:31:03.937312Z","steps":["trace[3767339] 'process raft request'  (duration: 270.556079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:31:03.937586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.988525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85f486c2-809e-4502-91ef-a9b732d6857d\" ","response":"range_response_count:1 size:3744"}
{"level":"info","ts":"2026-05-04T11:31:03.937708Z","caller":"traceutil/trace.go:171","msg":"trace[532631045] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85f486c2-809e-4502-91ef-a9b732d6857d; range_end:; response_count:1; response_revision:1874; }","duration":"175.183148ms","start":"2026-05-04T11:31:03.762495Z","end":"2026-05-04T11:31:03.937678Z","steps":["trace[532631045] 'agreement among raft nodes before linearized reading'  (duration: 174.850942ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:31:54.780747Z","caller":"traceutil/trace.go:171","msg":"trace[1157648688] linearizableReadLoop","detail":"{readStateIndex:2291; appliedIndex:2290; }","duration":"235.40788ms","start":"2026-05-04T11:31:54.545278Z","end":"2026-05-04T11:31:54.780686Z","steps":["trace[1157648688] 'read index received'  (duration: 235.201376ms)","trace[1157648688] 'applied index is now lower than readState.Index'  (duration: 205.374µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:31:54.780799Z","caller":"traceutil/trace.go:171","msg":"trace[7291912] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"263.216688ms","start":"2026-05-04T11:31:54.517534Z","end":"2026-05-04T11:31:54.780751Z","steps":["trace[7291912] 'process raft request'  (duration: 262.893202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:31:54.781038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.274915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-04T11:31:54.781045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.728717ms","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-04T11:31:54.78108Z","caller":"traceutil/trace.go:171","msg":"trace[1858127122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2208; }","duration":"144.377676ms","start":"2026-05-04T11:31:54.63669Z","end":"2026-05-04T11:31:54.781068Z","steps":["trace[1858127122] 'agreement among raft nodes before linearized reading'  (duration: 144.204093ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:31:54.781154Z","caller":"traceutil/trace.go:171","msg":"trace[986323196] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2208; }","duration":"235.848009ms","start":"2026-05-04T11:31:54.545271Z","end":"2026-05-04T11:31:54.781119Z","steps":["trace[986323196] 'agreement among raft nodes before linearized reading'  (duration: 235.549412ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:32:51.24148Z","caller":"traceutil/trace.go:171","msg":"trace[136923956] transaction","detail":"{read_only:false; response_revision:2681; number_of_response:1; }","duration":"125.311032ms","start":"2026-05-04T11:32:51.116119Z","end":"2026-05-04T11:32:51.24143Z","steps":["trace[136923956] 'process raft request'  (duration: 125.16396ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:33:24.568513Z","caller":"traceutil/trace.go:171","msg":"trace[438019922] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"107.74345ms","start":"2026-05-04T11:33:24.460738Z","end":"2026-05-04T11:33:24.568482Z","steps":["trace[438019922] 'process raft request'  (duration: 107.468395ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:33:24.894522Z","caller":"traceutil/trace.go:171","msg":"trace[737378305] linearizableReadLoop","detail":"{readStateIndex:2992; appliedIndex:2991; }","duration":"103.285643ms","start":"2026-05-04T11:33:24.791211Z","end":"2026-05-04T11:33:24.894497Z","steps":["trace[737378305] 'read index received'  (duration: 98.011353ms)","trace[737378305] 'applied index is now lower than readState.Index'  (duration: 5.27345ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:33:24.894542Z","caller":"traceutil/trace.go:171","msg":"trace[66621492] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"138.60211ms","start":"2026-05-04T11:33:24.755905Z","end":"2026-05-04T11:33:24.894507Z","steps":["trace[66621492] 'process raft request'  (duration: 133.439382ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:33:24.894739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.509227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-04T11:33:24.894794Z","caller":"traceutil/trace.go:171","msg":"trace[1053924614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2884; }","duration":"103.62081ms","start":"2026-05-04T11:33:24.791161Z","end":"2026-05-04T11:33:24.894782Z","steps":["trace[1053924614] 'agreement among raft nodes before linearized reading'  (duration: 103.420365ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:33:25.07013Z","caller":"traceutil/trace.go:171","msg":"trace[1780593963] transaction","detail":"{read_only:false; response_revision:2885; number_of_response:1; }","duration":"170.010551ms","start":"2026-05-04T11:33:24.900088Z","end":"2026-05-04T11:33:25.070098Z","steps":["trace[1780593963] 'process raft request'  (duration: 163.116532ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:31.234628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.386127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T11:37:31.234717Z","caller":"traceutil/trace.go:171","msg":"trace[1507791343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5010; }","duration":"114.522789ms","start":"2026-05-04T11:37:31.120176Z","end":"2026-05-04T11:37:31.234699Z","steps":["trace[1507791343] 'range keys from in-memory index tree'  (duration: 114.288735ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:35.565536Z","caller":"traceutil/trace.go:171","msg":"trace[580192940] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5142; }","duration":"208.396496ms","start":"2026-05-04T11:37:35.357116Z","end":"2026-05-04T11:37:35.565512Z","steps":["trace[580192940] 'process raft request'  (duration: 208.315635ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:35.565634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.322772ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T11:37:35.565737Z","caller":"traceutil/trace.go:171","msg":"trace[1402753992] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5142; }","duration":"116.434684ms","start":"2026-05-04T11:37:35.449277Z","end":"2026-05-04T11:37:35.565712Z","steps":["trace[1402753992] 'range keys from in-memory index tree'  (duration: 116.306521ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:35.565944Z","caller":"traceutil/trace.go:171","msg":"trace[1675446572] linearizableReadLoop","detail":"{readStateIndex:5337; appliedIndex:5336; }","duration":"141.63244ms","start":"2026-05-04T11:37:35.424243Z","end":"2026-05-04T11:37:35.565876Z","steps":["trace[1675446572] 'read index received'  (duration: 141.212672ms)","trace[1675446572] 'applied index is now lower than readState.Index'  (duration: 416.868µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T11:37:35.566188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.930816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1d815e7-8680-4ef2-bb42-fe91f9501077\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-04T11:37:35.566301Z","caller":"traceutil/trace.go:171","msg":"trace[305597014] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1d815e7-8680-4ef2-bb42-fe91f9501077; range_end:; response_count:1; response_revision:5142; }","duration":"142.10119ms","start":"2026-05-04T11:37:35.424178Z","end":"2026-05-04T11:37:35.566279Z","steps":["trace[305597014] 'agreement among raft nodes before linearized reading'  (duration: 141.817765ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:35.961497Z","caller":"traceutil/trace.go:171","msg":"trace[1586492681] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"205.024973ms","start":"2026-05-04T11:37:35.75645Z","end":"2026-05-04T11:37:35.961475Z","steps":["trace[1586492681] 'process raft request'  (duration: 204.87594ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:36.002468Z","caller":"traceutil/trace.go:171","msg":"trace[37742031] linearizableReadLoop","detail":"{readStateIndex:5349; appliedIndex:5346; }","duration":"229.73162ms","start":"2026-05-04T11:37:35.772703Z","end":"2026-05-04T11:37:36.002435Z","steps":["trace[37742031] 'read index received'  (duration: 188.65087ms)","trace[37742031] 'applied index is now lower than readState.Index'  (duration: 41.07935ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:37:36.002546Z","caller":"traceutil/trace.go:171","msg":"trace[1939569031] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"183.020745ms","start":"2026-05-04T11:37:35.819492Z","end":"2026-05-04T11:37:36.002513Z","steps":["trace[1939569031] 'process raft request'  (duration: 182.843892ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:36.002557Z","caller":"traceutil/trace.go:171","msg":"trace[412050540] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"177.189378ms","start":"2026-05-04T11:37:35.82534Z","end":"2026-05-04T11:37:36.002529Z","steps":["trace[412050540] 'process raft request'  (duration: 177.034065ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:36.002653Z","caller":"traceutil/trace.go:171","msg":"trace[937407222] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"245.038694ms","start":"2026-05-04T11:37:35.757589Z","end":"2026-05-04T11:37:36.002628Z","steps":["trace[937407222] 'process raft request'  (duration: 244.28211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:36.002681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.943934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T11:37:36.002723Z","caller":"traceutil/trace.go:171","msg":"trace[1962456115] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"214.429928ms","start":"2026-05-04T11:37:35.788283Z","end":"2026-05-04T11:37:36.002713Z","steps":["trace[1962456115] 'process raft request'  (duration: 213.995729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:36.00273Z","caller":"traceutil/trace.go:171","msg":"trace[1774994686] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:5157; }","duration":"230.067527ms","start":"2026-05-04T11:37:35.77265Z","end":"2026-05-04T11:37:36.002718Z","steps":["trace[1774994686] 'agreement among raft nodes before linearized reading'  (duration: 229.940584ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:36.002833Z","caller":"traceutil/trace.go:171","msg":"trace[129182267] transaction","detail":"{read_only:false; response_revision:5154; number_of_response:1; }","duration":"233.007181ms","start":"2026-05-04T11:37:35.769787Z","end":"2026-05-04T11:37:36.002794Z","steps":["trace[129182267] 'process raft request'  (duration: 232.39154ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:47.246749Z","caller":"traceutil/trace.go:171","msg":"trace[1042923650] linearizableReadLoop","detail":"{readStateIndex:5590; appliedIndex:5589; }","duration":"134.718844ms","start":"2026-05-04T11:37:47.111995Z","end":"2026-05-04T11:37:47.246714Z","steps":["trace[1042923650] 'read index received'  (duration: 76.633812ms)","trace[1042923650] 'applied index is now lower than readState.Index'  (duration: 58.083562ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:37:47.246807Z","caller":"traceutil/trace.go:171","msg":"trace[1144298489] transaction","detail":"{read_only:false; response_revision:5389; number_of_response:1; }","duration":"169.483678ms","start":"2026-05-04T11:37:47.077274Z","end":"2026-05-04T11:37:47.246758Z","steps":["trace[1144298489] 'process raft request'  (duration: 111.383185ms)","trace[1144298489] 'compare'  (duration: 57.832578ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T11:37:47.247158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.784673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T11:37:47.24717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.140782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-pzw8z.18ac59c21e5f1eac\" ","response":"range_response_count:1 size:832"}
{"level":"info","ts":"2026-05-04T11:37:47.247248Z","caller":"traceutil/trace.go:171","msg":"trace[1737759499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5389; }","duration":"128.939737ms","start":"2026-05-04T11:37:47.118293Z","end":"2026-05-04T11:37:47.247233Z","steps":["trace[1737759499] 'agreement among raft nodes before linearized reading'  (duration: 128.782713ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:47.247287Z","caller":"traceutil/trace.go:171","msg":"trace[3777975] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-pzw8z.18ac59c21e5f1eac; range_end:; response_count:1; response_revision:5389; }","duration":"135.332586ms","start":"2026-05-04T11:37:47.11193Z","end":"2026-05-04T11:37:47.247263Z","steps":["trace[3777975] 'agreement among raft nodes before linearized reading'  (duration: 134.913808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:47.247485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.816762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-05-04T11:37:47.247539Z","caller":"traceutil/trace.go:171","msg":"trace[1713594241] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:5389; }","duration":"121.940884ms","start":"2026-05-04T11:37:47.125586Z","end":"2026-05-04T11:37:47.247527Z","steps":["trace[1713594241] 'agreement among raft nodes before linearized reading'  (duration: 121.797892ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:47.247611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.615821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T11:37:47.247711Z","caller":"traceutil/trace.go:171","msg":"trace[1481163657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5389; }","duration":"127.785404ms","start":"2026-05-04T11:37:47.119904Z","end":"2026-05-04T11:37:47.247689Z","steps":["trace[1481163657] 'agreement among raft nodes before linearized reading'  (duration: 127.488719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:47.247748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.254885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130225"}
{"level":"info","ts":"2026-05-04T11:37:47.247829Z","caller":"traceutil/trace.go:171","msg":"trace[1921651226] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5389; }","duration":"118.390187ms","start":"2026-05-04T11:37:47.12942Z","end":"2026-05-04T11:37:47.24781Z","steps":["trace[1921651226] 'agreement among raft nodes before linearized reading'  (duration: 118.070872ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:47.427864Z","caller":"traceutil/trace.go:171","msg":"trace[1315906612] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"176.239585ms","start":"2026-05-04T11:37:47.251592Z","end":"2026-05-04T11:37:47.427831Z","steps":["trace[1315906612] 'process raft request'  (duration: 101.479968ms)","trace[1315906612] 'compare'  (duration: 74.495682ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:37:47.42794Z","caller":"traceutil/trace.go:171","msg":"trace[1409842975] linearizableReadLoop","detail":"{readStateIndex:5594; appliedIndex:5591; }","duration":"171.64098ms","start":"2026-05-04T11:37:47.256262Z","end":"2026-05-04T11:37:47.427903Z","steps":["trace[1409842975] 'read index received'  (duration: 96.864442ms)","trace[1409842975] 'applied index is now lower than readState.Index'  (duration: 74.775398ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:37:47.427993Z","caller":"traceutil/trace.go:171","msg":"trace[632808819] transaction","detail":"{read_only:false; response_revision:5393; number_of_response:1; }","duration":"175.472732ms","start":"2026-05-04T11:37:47.252498Z","end":"2026-05-04T11:37:47.42797Z","steps":["trace[632808819] 'process raft request'  (duration: 175.330569ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:47.428261Z","caller":"traceutil/trace.go:171","msg":"trace[1877858178] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"176.135523ms","start":"2026-05-04T11:37:47.251855Z","end":"2026-05-04T11:37:47.42799Z","steps":["trace[1877858178] 'process raft request'  (duration: 175.916208ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:47.428337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.814266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:47 size:69249"}
{"level":"info","ts":"2026-05-04T11:37:47.428367Z","caller":"traceutil/trace.go:171","msg":"trace[1000389574] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:47; response_revision:5393; }","duration":"176.886177ms","start":"2026-05-04T11:37:47.251474Z","end":"2026-05-04T11:37:47.42836Z","steps":["trace[1000389574] 'agreement among raft nodes before linearized reading'  (duration: 176.583012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:47.428434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.341459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130225"}
{"level":"info","ts":"2026-05-04T11:37:47.428528Z","caller":"traceutil/trace.go:171","msg":"trace[1268140225] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5393; }","duration":"167.445381ms","start":"2026-05-04T11:37:47.261059Z","end":"2026-05-04T11:37:47.428504Z","steps":["trace[1268140225] 'agreement among raft nodes before linearized reading'  (duration: 167.098114ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:47.428422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.688379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T11:37:47.428646Z","caller":"traceutil/trace.go:171","msg":"trace[904765475] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:5393; }","duration":"147.946884ms","start":"2026-05-04T11:37:47.280674Z","end":"2026-05-04T11:37:47.428621Z","steps":["trace[904765475] 'agreement among raft nodes before linearized reading'  (duration: 147.621338ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:47.984408Z","caller":"traceutil/trace.go:171","msg":"trace[2081983018] transaction","detail":"{read_only:false; response_revision:5395; number_of_response:1; }","duration":"109.068592ms","start":"2026-05-04T11:37:47.875301Z","end":"2026-05-04T11:37:47.98437Z","steps":["trace[2081983018] 'process raft request'  (duration: 108.757356ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:55.776001Z","caller":"traceutil/trace.go:171","msg":"trace[1943828606] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"235.375629ms","start":"2026-05-04T11:37:55.540579Z","end":"2026-05-04T11:37:55.775955Z","steps":["trace[1943828606] 'process raft request'  (duration: 235.056653ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.203317Z","caller":"traceutil/trace.go:171","msg":"trace[912418844] transaction","detail":"{read_only:false; response_revision:5575; number_of_response:1; }","duration":"162.832503ms","start":"2026-05-04T11:37:56.040429Z","end":"2026-05-04T11:37:56.203262Z","steps":["trace[912418844] 'process raft request'  (duration: 144.975257ms)","trace[912418844] 'compare'  (duration: 17.668673ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:37:56.203374Z","caller":"traceutil/trace.go:171","msg":"trace[328986469] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"161.948227ms","start":"2026-05-04T11:37:56.041382Z","end":"2026-05-04T11:37:56.20333Z","steps":["trace[328986469] 'process raft request'  (duration: 161.800155ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.203512Z","caller":"traceutil/trace.go:171","msg":"trace[41466444] linearizableReadLoop","detail":"{readStateIndex:5783; appliedIndex:5779; }","duration":"161.715642ms","start":"2026-05-04T11:37:56.041772Z","end":"2026-05-04T11:37:56.203487Z","steps":["trace[41466444] 'read index received'  (duration: 3.864773ms)","trace[41466444] 'applied index is now lower than readState.Index'  (duration: 157.849859ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:37:56.203801Z","caller":"traceutil/trace.go:171","msg":"trace[591181869] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"159.54896ms","start":"2026-05-04T11:37:56.044236Z","end":"2026-05-04T11:37:56.203785Z","steps":["trace[591181869] 'process raft request'  (duration: 159.130563ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.203859Z","caller":"traceutil/trace.go:171","msg":"trace[1304533474] transaction","detail":"{read_only:false; response_revision:5580; number_of_response:1; }","duration":"159.499231ms","start":"2026-05-04T11:37:56.044346Z","end":"2026-05-04T11:37:56.203845Z","steps":["trace[1304533474] 'process raft request'  (duration: 159.078443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:56.204091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.287953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4186233b-ee9c-45b3-aeb4-ea9cc3c0a4c6\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-04T11:37:56.204164Z","caller":"traceutil/trace.go:171","msg":"trace[1343904952] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4186233b-ee9c-45b3-aeb4-ea9cc3c0a4c6; range_end:; response_count:1; response_revision:5580; }","duration":"162.394236ms","start":"2026-05-04T11:37:56.041749Z","end":"2026-05-04T11:37:56.204143Z","steps":["trace[1343904952] 'agreement among raft nodes before linearized reading'  (duration: 162.177502ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.204268Z","caller":"traceutil/trace.go:171","msg":"trace[527836081] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"162.598529ms","start":"2026-05-04T11:37:56.041617Z","end":"2026-05-04T11:37:56.204216Z","steps":["trace[527836081] 'process raft request'  (duration: 161.641821ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.204611Z","caller":"traceutil/trace.go:171","msg":"trace[782129082] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"162.68346ms","start":"2026-05-04T11:37:56.041816Z","end":"2026-05-04T11:37:56.204499Z","steps":["trace[782129082] 'process raft request'  (duration: 161.498158ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.217824Z","caller":"traceutil/trace.go:171","msg":"trace[1408226903] transaction","detail":"{read_only:false; response_revision:5582; number_of_response:1; }","duration":"130.78663ms","start":"2026-05-04T11:37:56.087014Z","end":"2026-05-04T11:37:56.217801Z","steps":["trace[1408226903] 'process raft request'  (duration: 130.715639ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:37:56.217951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.701116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f1d815e7-8680-4ef2-bb42-fe91f9501077\" ","response":"range_response_count:1 size:1275"}
{"level":"info","ts":"2026-05-04T11:37:56.217998Z","caller":"traceutil/trace.go:171","msg":"trace[1654423578] transaction","detail":"{read_only:false; response_revision:5581; number_of_response:1; }","duration":"135.471589ms","start":"2026-05-04T11:37:56.082519Z","end":"2026-05-04T11:37:56.217991Z","steps":["trace[1654423578] 'process raft request'  (duration: 135.089951ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:37:56.218003Z","caller":"traceutil/trace.go:171","msg":"trace[15773033] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f1d815e7-8680-4ef2-bb42-fe91f9501077; range_end:; response_count:1; response_revision:5582; }","duration":"175.789087ms","start":"2026-05-04T11:37:56.0422Z","end":"2026-05-04T11:37:56.217989Z","steps":["trace[15773033] 'agreement among raft nodes before linearized reading'  (duration: 175.573773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:38:45.839869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3001}
{"level":"info","ts":"2026-05-04T11:38:45.929962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3001,"took":"86.707872ms","hash":1226981728,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31219712,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-04T11:38:45.930046Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1226981728,"revision":3001,"compact-revision":-1}
{"level":"info","ts":"2026-05-04T11:43:45.846443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6047}
{"level":"info","ts":"2026-05-04T11:43:45.955656Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6047,"took":"106.793945ms","hash":3761721947,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":21778432,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-04T11:43:45.955764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3761721947,"revision":6047,"compact-revision":3001}
{"level":"info","ts":"2026-05-04T11:44:24.346214Z","caller":"traceutil/trace.go:171","msg":"trace[277040333] transaction","detail":"{read_only:false; response_revision:8503; number_of_response:1; }","duration":"121.282389ms","start":"2026-05-04T11:44:24.224884Z","end":"2026-05-04T11:44:24.346166Z","steps":["trace[277040333] 'process raft request'  (duration: 101.914703ms)","trace[277040333] 'compare'  (duration: 19.161912ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:44:24.964614Z","caller":"traceutil/trace.go:171","msg":"trace[2020915490] transaction","detail":"{read_only:false; response_revision:8505; number_of_response:1; }","duration":"203.127153ms","start":"2026-05-04T11:44:24.761457Z","end":"2026-05-04T11:44:24.964584Z","steps":["trace[2020915490] 'process raft request'  (duration: 202.94779ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:44:25.773247Z","caller":"traceutil/trace.go:171","msg":"trace[166601481] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"108.10145ms","start":"2026-05-04T11:44:25.665104Z","end":"2026-05-04T11:44:25.773206Z","steps":["trace[166601481] 'process raft request'  (duration: 107.889666ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:44:27.195013Z","caller":"traceutil/trace.go:171","msg":"trace[1755830511] linearizableReadLoop","detail":"{readStateIndex:8817; appliedIndex:8816; }","duration":"113.499932ms","start":"2026-05-04T11:44:27.081479Z","end":"2026-05-04T11:44:27.194978Z","steps":["trace[1755830511] 'read index received'  (duration: 113.239768ms)","trace[1755830511] 'applied index is now lower than readState.Index'  (duration: 258.874µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:44:27.195151Z","caller":"traceutil/trace.go:171","msg":"trace[1564486570] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"146.888631ms","start":"2026-05-04T11:44:27.04825Z","end":"2026-05-04T11:44:27.195139Z","steps":["trace[1564486570] 'process raft request'  (duration: 146.563295ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:44:27.195622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.125744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T11:44:27.195674Z","caller":"traceutil/trace.go:171","msg":"trace[443400419] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:8517; }","duration":"114.261317ms","start":"2026-05-04T11:44:27.081401Z","end":"2026-05-04T11:44:27.195663Z","steps":["trace[443400419] 'agreement among raft nodes before linearized reading'  (duration: 114.051463ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:44:54.584884Z","caller":"traceutil/trace.go:171","msg":"trace[1226471279] transaction","detail":"{read_only:false; response_revision:8719; number_of_response:1; }","duration":"216.197841ms","start":"2026-05-04T11:44:54.368658Z","end":"2026-05-04T11:44:54.584856Z","steps":["trace[1226471279] 'process raft request'  (duration: 214.130631ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:45:08.065644Z","caller":"traceutil/trace.go:171","msg":"trace[929531930] transaction","detail":"{read_only:false; response_revision:8828; number_of_response:1; }","duration":"166.646765ms","start":"2026-05-04T11:45:07.89897Z","end":"2026-05-04T11:45:08.065616Z","steps":["trace[929531930] 'process raft request'  (duration: 166.442561ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:45:08.149227Z","caller":"traceutil/trace.go:171","msg":"trace[845043454] transaction","detail":"{read_only:false; response_revision:8829; number_of_response:1; }","duration":"241.07767ms","start":"2026-05-04T11:45:07.908112Z","end":"2026-05-04T11:45:08.14919Z","steps":["trace[845043454] 'process raft request'  (duration: 240.841934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:45:08.149351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.041988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T11:45:08.149396Z","caller":"traceutil/trace.go:171","msg":"trace[778840585] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8831; }","duration":"216.151029ms","start":"2026-05-04T11:45:07.933234Z","end":"2026-05-04T11:45:08.149385Z","steps":["trace[778840585] 'agreement among raft nodes before linearized reading'  (duration: 216.051497ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:45:08.149336Z","caller":"traceutil/trace.go:171","msg":"trace[77866232] transaction","detail":"{read_only:false; response_revision:8830; number_of_response:1; }","duration":"140.206945ms","start":"2026-05-04T11:45:08.009073Z","end":"2026-05-04T11:45:08.14928Z","steps":["trace[77866232] 'process raft request'  (duration: 140.039562ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:45:08.149221Z","caller":"traceutil/trace.go:171","msg":"trace[107363183] linearizableReadLoop","detail":"{readStateIndex:9142; appliedIndex:9140; }","duration":"215.911845ms","start":"2026-05-04T11:45:07.933289Z","end":"2026-05-04T11:45:08.149201Z","steps":["trace[107363183] 'read index received'  (duration: 132.086353ms)","trace[107363183] 'applied index is now lower than readState.Index'  (duration: 83.824662ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:45:08.150254Z","caller":"traceutil/trace.go:171","msg":"trace[864317287] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"106.327926ms","start":"2026-05-04T11:45:08.043716Z","end":"2026-05-04T11:45:08.150044Z","steps":["trace[864317287] 'process raft request'  (duration: 105.44774ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:45:08.190965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.915585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-05-04T11:45:08.191113Z","caller":"traceutil/trace.go:171","msg":"trace[785993326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8832; }","duration":"179.086199ms","start":"2026-05-04T11:45:08.011996Z","end":"2026-05-04T11:45:08.191082Z","steps":["trace[785993326] 'agreement among raft nodes before linearized reading'  (duration: 178.753762ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:45:09.162791Z","caller":"traceutil/trace.go:171","msg":"trace[1340673226] linearizableReadLoop","detail":"{readStateIndex:9152; appliedIndex:9151; }","duration":"269.011757ms","start":"2026-05-04T11:45:08.893749Z","end":"2026-05-04T11:45:09.16276Z","steps":["trace[1340673226] 'read index received'  (duration: 268.837203ms)","trace[1340673226] 'applied index is now lower than readState.Index'  (duration: 173.504µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T11:45:09.16284Z","caller":"traceutil/trace.go:171","msg":"trace[1980369839] transaction","detail":"{read_only:false; response_revision:8839; number_of_response:1; }","duration":"288.878371ms","start":"2026-05-04T11:45:08.873939Z","end":"2026-05-04T11:45:09.162817Z","steps":["trace[1980369839] 'process raft request'  (duration: 288.640336ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:45:09.163134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.767964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-04T11:45:09.163186Z","caller":"traceutil/trace.go:171","msg":"trace[572372266] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:8839; }","duration":"213.876596ms","start":"2026-05-04T11:45:08.949295Z","end":"2026-05-04T11:45:09.163171Z","steps":["trace[572372266] 'agreement among raft nodes before linearized reading'  (duration: 213.748684ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:45:09.163135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.338393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-04T11:45:09.163377Z","caller":"traceutil/trace.go:171","msg":"trace[1127214024] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8839; }","duration":"269.67698ms","start":"2026-05-04T11:45:08.893691Z","end":"2026-05-04T11:45:09.163368Z","steps":["trace[1127214024] 'agreement among raft nodes before linearized reading'  (duration: 269.253192ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:45:23.776102Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002447.wal"}
{"level":"info","ts":"2026-05-04T11:46:35.772632Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"572db18442eba1c2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T11:46:35.77806Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-04T11:46:35.778192Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-04T11:48:45.8523Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8126}
{"level":"info","ts":"2026-05-04T11:48:45.917437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8126,"took":"62.547272ms","hash":907220623,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":28418048,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-04T11:48:45.917512Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":907220623,"revision":8126,"compact-revision":6047}
{"level":"info","ts":"2026-05-04T11:52:04.11343Z","caller":"traceutil/trace.go:171","msg":"trace[1589084150] transaction","detail":"{read_only:false; response_revision:12016; number_of_response:1; }","duration":"215.144744ms","start":"2026-05-04T11:52:03.898255Z","end":"2026-05-04T11:52:04.113399Z","steps":["trace[1589084150] 'process raft request'  (duration: 213.533043ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:52:04.141683Z","caller":"traceutil/trace.go:171","msg":"trace[2134995474] transaction","detail":"{read_only:false; response_revision:12017; number_of_response:1; }","duration":"242.125575ms","start":"2026-05-04T11:52:03.899527Z","end":"2026-05-04T11:52:04.141653Z","steps":["trace[2134995474] 'process raft request'  (duration: 241.943912ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:52:04.142009Z","caller":"traceutil/trace.go:171","msg":"trace[1728852607] transaction","detail":"{read_only:false; response_revision:12018; number_of_response:1; }","duration":"225.905198ms","start":"2026-05-04T11:52:03.916069Z","end":"2026-05-04T11:52:04.141974Z","steps":["trace[1728852607] 'process raft request'  (duration: 225.542012ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:52:04.142114Z","caller":"traceutil/trace.go:171","msg":"trace[527388588] transaction","detail":"{read_only:false; response_revision:12019; number_of_response:1; }","duration":"135.007776ms","start":"2026-05-04T11:52:04.007066Z","end":"2026-05-04T11:52:04.142074Z","steps":["trace[527388588] 'process raft request'  (duration: 134.878304ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:53:45.858707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10532}
{"level":"info","ts":"2026-05-04T11:53:45.938341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10532,"took":"77.130277ms","hash":1522806155,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":26439680,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-04T11:53:45.938419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1522806155,"revision":10532,"compact-revision":8126}
{"level":"info","ts":"2026-05-04T11:58:45.866667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12712}
{"level":"info","ts":"2026-05-04T11:58:45.94727Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12712,"took":"77.074166ms","hash":545394801,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":27017216,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-04T11:58:45.947369Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":545394801,"revision":12712,"compact-revision":10532}
{"level":"warn","ts":"2026-05-04T11:59:00.853712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.209842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-04T11:59:00.85384Z","caller":"traceutil/trace.go:171","msg":"trace[615655442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14772; }","duration":"291.352665ms","start":"2026-05-04T11:59:00.562462Z","end":"2026-05-04T11:59:00.853815Z","steps":["trace[615655442] 'range keys from in-memory index tree'  (duration: 290.921417ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:59:00.853842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.628116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-04T11:59:00.853957Z","caller":"traceutil/trace.go:171","msg":"trace[1681513647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14772; }","duration":"294.798638ms","start":"2026-05-04T11:59:00.559138Z","end":"2026-05-04T11:59:00.853937Z","steps":["trace[1681513647] 'range keys from in-memory index tree'  (duration: 294.426102ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:59:00.854296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.192894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:16 size:151651"}
{"level":"info","ts":"2026-05-04T11:59:00.854421Z","caller":"traceutil/trace.go:171","msg":"trace[1888124651] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:16; response_revision:14772; }","duration":"345.371847ms","start":"2026-05-04T11:59:00.509023Z","end":"2026-05-04T11:59:00.854395Z","steps":["trace[1888124651] 'range keys from in-memory index tree'  (duration: 344.648054ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T11:59:00.854483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T11:59:00.508998Z","time spent":"345.47424ms","remote":"127.0.0.1:37420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":16,"response size":151674,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"warn","ts":"2026-05-04T11:59:10.06602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.406909ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507616582 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/data-ovn-ovsdb-nb-0.18ac5af2154641a4\" mod_revision:14907 > success:<request_put:<key:\"/registry/events/openstack/data-ovn-ovsdb-nb-0.18ac5af2154641a4\" value_size:860 lease:2432680414652840095 >> failure:<request_range:<key:\"/registry/events/openstack/data-ovn-ovsdb-nb-0.18ac5af2154641a4\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T11:59:10.066231Z","caller":"traceutil/trace.go:171","msg":"trace[1549296819] transaction","detail":"{read_only:false; response_revision:14943; number_of_response:1; }","duration":"243.261633ms","start":"2026-05-04T11:59:09.82295Z","end":"2026-05-04T11:59:10.066212Z","steps":["trace[1549296819] 'process raft request'  (duration: 243.194372ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T11:59:10.066235Z","caller":"traceutil/trace.go:171","msg":"trace[688287685] transaction","detail":"{read_only:false; response_revision:14942; number_of_response:1; }","duration":"260.006857ms","start":"2026-05-04T11:59:09.806197Z","end":"2026-05-04T11:59:10.066204Z","steps":["trace[688287685] 'process raft request'  (duration: 84.189789ms)","trace[688287685] 'compare'  (duration: 175.274277ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:01:00.965608Z","caller":"traceutil/trace.go:171","msg":"trace[1212314563] transaction","detail":"{read_only:false; response_revision:16119; number_of_response:1; }","duration":"143.027203ms","start":"2026-05-04T12:01:00.822539Z","end":"2026-05-04T12:01:00.965566Z","steps":["trace[1212314563] 'process raft request'  (duration: 142.795149ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:03:45.871975Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14682}
{"level":"info","ts":"2026-05-04T12:03:45.943536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14682,"took":"68.757098ms","hash":708261085,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":32362496,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-04T12:03:45.943613Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":708261085,"revision":14682,"compact-revision":12712}
{"level":"info","ts":"2026-05-04T12:06:27.96641Z","caller":"traceutil/trace.go:171","msg":"trace[2127789098] linearizableReadLoop","detail":"{readStateIndex:19298; appliedIndex:19297; }","duration":"147.090899ms","start":"2026-05-04T12:06:27.819293Z","end":"2026-05-04T12:06:27.966383Z","steps":["trace[2127789098] 'read index received'  (duration: 146.916276ms)","trace[2127789098] 'applied index is now lower than readState.Index'  (duration: 170.873µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:06:27.966514Z","caller":"traceutil/trace.go:171","msg":"trace[221982022] transaction","detail":"{read_only:false; response_revision:18667; number_of_response:1; }","duration":"191.778107ms","start":"2026-05-04T12:06:27.774707Z","end":"2026-05-04T12:06:27.966485Z","steps":["trace[221982022] 'process raft request'  (duration: 191.486931ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:06:27.966771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.448715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-04T12:06:27.966837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.630879ms","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-04T12:06:27.966823Z","caller":"traceutil/trace.go:171","msg":"trace[2078103276] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18667; }","duration":"147.542676ms","start":"2026-05-04T12:06:27.819267Z","end":"2026-05-04T12:06:27.966809Z","steps":["trace[2078103276] 'agreement among raft nodes before linearized reading'  (duration: 147.332923ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:06:27.966889Z","caller":"traceutil/trace.go:171","msg":"trace[335891466] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18667; }","duration":"146.716112ms","start":"2026-05-04T12:06:27.820158Z","end":"2026-05-04T12:06:27.966874Z","steps":["trace[335891466] 'agreement among raft nodes before linearized reading'  (duration: 146.539088ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:06:34.175562Z","caller":"traceutil/trace.go:171","msg":"trace[1879244356] linearizableReadLoop","detail":"{readStateIndex:19364; appliedIndex:19363; }","duration":"114.576859ms","start":"2026-05-04T12:06:34.060955Z","end":"2026-05-04T12:06:34.175531Z","steps":["trace[1879244356] 'read index received'  (duration: 95.45565ms)","trace[1879244356] 'applied index is now lower than readState.Index'  (duration: 19.119419ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:06:34.175688Z","caller":"traceutil/trace.go:171","msg":"trace[1491580666] transaction","detail":"{read_only:false; response_revision:18731; number_of_response:1; }","duration":"149.554185ms","start":"2026-05-04T12:06:34.026083Z","end":"2026-05-04T12:06:34.175638Z","steps":["trace[1491580666] 'process raft request'  (duration: 130.418965ms)","trace[1491580666] 'compare'  (duration: 18.847473ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:06:34.175768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.793002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:06:34.175878Z","caller":"traceutil/trace.go:171","msg":"trace[895496674] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:18731; }","duration":"114.969345ms","start":"2026-05-04T12:06:34.060884Z","end":"2026-05-04T12:06:34.175854Z","steps":["trace[895496674] 'agreement among raft nodes before linearized reading'  (duration: 114.761122ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:07:27.511731Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"572db18442eba1c2","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T12:07:27.516797Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-04T12:07:27.516869Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-04T12:08:45.877735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17313}
{"level":"info","ts":"2026-05-04T12:08:45.971806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17313,"took":"91.117936ms","hash":1018105800,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":34697216,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-04T12:08:45.971872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1018105800,"revision":17313,"compact-revision":14682}
{"level":"info","ts":"2026-05-04T12:12:03.794502Z","caller":"traceutil/trace.go:171","msg":"trace[435922825] transaction","detail":"{read_only:false; response_revision:21237; number_of_response:1; }","duration":"172.946073ms","start":"2026-05-04T12:12:03.621529Z","end":"2026-05-04T12:12:03.794475Z","steps":["trace[435922825] 'process raft request'  (duration: 172.7485ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:12:10.031872Z","caller":"traceutil/trace.go:171","msg":"trace[2119292268] transaction","detail":"{read_only:false; response_revision:21269; number_of_response:1; }","duration":"149.007415ms","start":"2026-05-04T12:12:09.882822Z","end":"2026-05-04T12:12:10.03183Z","steps":["trace[2119292268] 'process raft request'  (duration: 144.153774ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:12:10.050457Z","caller":"traceutil/trace.go:171","msg":"trace[849749040] transaction","detail":"{read_only:false; response_revision:21270; number_of_response:1; }","duration":"167.525282ms","start":"2026-05-04T12:12:09.882893Z","end":"2026-05-04T12:12:10.050418Z","steps":["trace[849749040] 'process raft request'  (duration: 167.271427ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:12:10.488232Z","caller":"traceutil/trace.go:171","msg":"trace[131584931] transaction","detail":"{read_only:false; response_revision:21271; number_of_response:1; }","duration":"107.793772ms","start":"2026-05-04T12:12:10.380405Z","end":"2026-05-04T12:12:10.488198Z","steps":["trace[131584931] 'process raft request'  (duration: 107.629699ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:13:45.884878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19855}
{"level":"info","ts":"2026-05-04T12:13:45.995466Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19855,"took":"107.450255ms","hash":932887181,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30375936,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-04T12:13:45.995562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":932887181,"revision":19855,"compact-revision":17313}
{"level":"info","ts":"2026-05-04T12:15:57.384757Z","caller":"traceutil/trace.go:171","msg":"trace[455997781] linearizableReadLoop","detail":"{readStateIndex:24480; appliedIndex:24479; }","duration":"169.559438ms","start":"2026-05-04T12:15:57.21516Z","end":"2026-05-04T12:15:57.384719Z","steps":["trace[455997781] 'read index received'  (duration: 169.434806ms)","trace[455997781] 'applied index is now lower than readState.Index'  (duration: 123.232µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:15:57.384823Z","caller":"traceutil/trace.go:171","msg":"trace[399077798] transaction","detail":"{read_only:false; response_revision:23688; number_of_response:1; }","duration":"176.03917ms","start":"2026-05-04T12:15:57.208736Z","end":"2026-05-04T12:15:57.384775Z","steps":["trace[399077798] 'process raft request'  (duration: 175.782865ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:15:57.38527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.045827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/capi-kubeadm-control-plane-system/capi-kubeadm-control-plane-manager\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-05-04T12:15:57.385426Z","caller":"traceutil/trace.go:171","msg":"trace[2077013860] range","detail":"{range_begin:/registry/serviceaccounts/capi-kubeadm-control-plane-system/capi-kubeadm-control-plane-manager; range_end:; response_count:1; response_revision:23688; }","duration":"170.256091ms","start":"2026-05-04T12:15:57.215136Z","end":"2026-05-04T12:15:57.385392Z","steps":["trace[2077013860] 'agreement among raft nodes before linearized reading'  (duration: 169.737992ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:15:57.553416Z","caller":"traceutil/trace.go:171","msg":"trace[1859609418] transaction","detail":"{read_only:false; response_revision:23689; number_of_response:1; }","duration":"276.882011ms","start":"2026-05-04T12:15:57.276487Z","end":"2026-05-04T12:15:57.553369Z","steps":["trace[1859609418] 'process raft request'  (duration: 270.890598ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:15:57.553446Z","caller":"traceutil/trace.go:171","msg":"trace[1942354035] linearizableReadLoop","detail":"{readStateIndex:24482; appliedIndex:24480; }","duration":"168.545429ms","start":"2026-05-04T12:15:57.384856Z","end":"2026-05-04T12:15:57.553402Z","steps":["trace[1942354035] 'read index received'  (duration: 162.641989ms)","trace[1942354035] 'applied index is now lower than readState.Index'  (duration: 5.90148ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:15:57.553474Z","caller":"traceutil/trace.go:171","msg":"trace[1003981121] transaction","detail":"{read_only:false; response_revision:23690; number_of_response:1; }","duration":"252.029045ms","start":"2026-05-04T12:15:57.301406Z","end":"2026-05-04T12:15:57.553435Z","steps":["trace[1003981121] 'process raft request'  (duration: 251.881522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:15:57.553616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.952599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7533"}
{"level":"info","ts":"2026-05-04T12:15:57.553679Z","caller":"traceutil/trace.go:171","msg":"trace[1006261650] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:23690; }","duration":"240.07144ms","start":"2026-05-04T12:15:57.313591Z","end":"2026-05-04T12:15:57.553663Z","steps":["trace[1006261650] 'agreement among raft nodes before linearized reading'  (duration: 239.847516ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:15:57.554716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.063419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-04T12:15:57.555906Z","caller":"traceutil/trace.go:171","msg":"trace[1380252155] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23690; }","duration":"306.619058ms","start":"2026-05-04T12:15:57.249263Z","end":"2026-05-04T12:15:57.555882Z","steps":["trace[1380252155] 'agreement among raft nodes before linearized reading'  (duration: 304.259323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:15:57.555947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:15:57.249226Z","time spent":"306.71076ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-04T12:15:57.560417Z","caller":"traceutil/trace.go:171","msg":"trace[2003142135] transaction","detail":"{read_only:false; response_revision:23691; number_of_response:1; }","duration":"129.364255ms","start":"2026-05-04T12:15:57.431037Z","end":"2026-05-04T12:15:57.560401Z","steps":["trace[2003142135] 'process raft request'  (duration: 128.912377ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:15:57.560554Z","caller":"traceutil/trace.go:171","msg":"trace[1237902479] transaction","detail":"{read_only:false; response_revision:23692; number_of_response:1; }","duration":"128.068351ms","start":"2026-05-04T12:15:57.432475Z","end":"2026-05-04T12:15:57.560544Z","steps":["trace[1237902479] 'process raft request'  (duration: 127.581602ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:15:57.560644Z","caller":"traceutil/trace.go:171","msg":"trace[788967654] transaction","detail":"{read_only:false; response_revision:23693; number_of_response:1; }","duration":"123.076338ms","start":"2026-05-04T12:15:57.437562Z","end":"2026-05-04T12:15:57.560638Z","steps":["trace[788967654] 'process raft request'  (duration: 122.527808ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:15:57.560739Z","caller":"traceutil/trace.go:171","msg":"trace[1296961986] transaction","detail":"{read_only:false; response_revision:23694; number_of_response:1; }","duration":"119.662423ms","start":"2026-05-04T12:15:57.441067Z","end":"2026-05-04T12:15:57.560729Z","steps":["trace[1296961986] 'process raft request'  (duration: 119.052252ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:15:57.561246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.621865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/capi-kubeadm-control-plane-system/capi-kubeadm-control-plane-controller-manager-bdfc6fdd8-4lkjl\" ","response":"range_response_count:1 size:5303"}
{"level":"info","ts":"2026-05-04T12:15:57.56128Z","caller":"traceutil/trace.go:171","msg":"trace[1765867411] range","detail":"{range_begin:/registry/pods/capi-kubeadm-control-plane-system/capi-kubeadm-control-plane-controller-manager-bdfc6fdd8-4lkjl; range_end:; response_count:1; response_revision:23695; }","duration":"173.684256ms","start":"2026-05-04T12:15:57.387585Z","end":"2026-05-04T12:15:57.561269Z","steps":["trace[1765867411] 'agreement among raft nodes before linearized reading'  (duration: 173.546673ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:45.891369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22090}
{"level":"info","ts":"2026-05-04T12:18:46.006172Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22090,"took":"110.316064ms","hash":1702484804,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":44150784,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-05-04T12:18:46.006259Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1702484804,"revision":22090,"compact-revision":19855}
{"level":"info","ts":"2026-05-04T12:18:51.096193Z","caller":"traceutil/trace.go:171","msg":"trace[382309737] transaction","detail":"{read_only:false; response_revision:25504; number_of_response:1; }","duration":"242.306762ms","start":"2026-05-04T12:18:50.853857Z","end":"2026-05-04T12:18:51.096164Z","steps":["trace[382309737] 'process raft request'  (duration: 242.050468ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:51.096553Z","caller":"traceutil/trace.go:171","msg":"trace[2049808029] linearizableReadLoop","detail":"{readStateIndex:26343; appliedIndex:26343; }","duration":"111.028898ms","start":"2026-05-04T12:18:50.985514Z","end":"2026-05-04T12:18:51.096543Z","steps":["trace[2049808029] 'read index received'  (duration: 111.024348ms)","trace[2049808029] 'applied index is now lower than readState.Index'  (duration: 3.75µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:18:51.096923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.396204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:18:51.096992Z","caller":"traceutil/trace.go:171","msg":"trace[1327531419] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:25504; }","duration":"111.526897ms","start":"2026-05-04T12:18:50.98545Z","end":"2026-05-04T12:18:51.096977Z","steps":["trace[1327531419] 'agreement among raft nodes before linearized reading'  (duration: 111.412565ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:51.625363Z","caller":"traceutil/trace.go:171","msg":"trace[398932088] transaction","detail":"{read_only:false; response_revision:25505; number_of_response:1; }","duration":"118.687429ms","start":"2026-05-04T12:18:51.506644Z","end":"2026-05-04T12:18:51.625332Z","steps":["trace[398932088] 'process raft request'  (duration: 118.373473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:52.346332Z","caller":"traceutil/trace.go:171","msg":"trace[1081675717] transaction","detail":"{read_only:false; response_revision:25507; number_of_response:1; }","duration":"129.38017ms","start":"2026-05-04T12:18:52.216918Z","end":"2026-05-04T12:18:52.346299Z","steps":["trace[1081675717] 'process raft request'  (duration: 129.174686ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:52.347738Z","caller":"traceutil/trace.go:171","msg":"trace[1324337590] transaction","detail":"{read_only:false; response_revision:25508; number_of_response:1; }","duration":"122.797486ms","start":"2026-05-04T12:18:52.224905Z","end":"2026-05-04T12:18:52.347702Z","steps":["trace[1324337590] 'process raft request'  (duration: 122.589842ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:52.34775Z","caller":"traceutil/trace.go:171","msg":"trace[1154207962] transaction","detail":"{read_only:false; response_revision:25509; number_of_response:1; }","duration":"116.225275ms","start":"2026-05-04T12:18:52.2315Z","end":"2026-05-04T12:18:52.347725Z","steps":["trace[1154207962] 'process raft request'  (duration: 116.126393ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:52.614345Z","caller":"traceutil/trace.go:171","msg":"trace[843353338] linearizableReadLoop","detail":"{readStateIndex:26349; appliedIndex:26348; }","duration":"206.250699ms","start":"2026-05-04T12:18:52.408047Z","end":"2026-05-04T12:18:52.614298Z","steps":["trace[843353338] 'read index received'  (duration: 133.678941ms)","trace[843353338] 'applied index is now lower than readState.Index'  (duration: 72.570298ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:18:52.614369Z","caller":"traceutil/trace.go:171","msg":"trace[1966736887] transaction","detail":"{read_only:false; response_revision:25510; number_of_response:1; }","duration":"261.90308ms","start":"2026-05-04T12:18:52.352424Z","end":"2026-05-04T12:18:52.614327Z","steps":["trace[1966736887] 'process raft request'  (duration: 189.288231ms)","trace[1966736887] 'compare'  (duration: 72.386055ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:18:52.614668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.572655ms","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-04T12:18:52.614785Z","caller":"traceutil/trace.go:171","msg":"trace[1395235965] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25510; }","duration":"206.788958ms","start":"2026-05-04T12:18:52.407972Z","end":"2026-05-04T12:18:52.614761Z","steps":["trace[1395235965] 'agreement among raft nodes before linearized reading'  (duration: 206.429462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:52.615146Z","caller":"traceutil/trace.go:171","msg":"trace[378425205] transaction","detail":"{read_only:false; response_revision:25511; number_of_response:1; }","duration":"104.924563ms","start":"2026-05-04T12:18:52.510203Z","end":"2026-05-04T12:18:52.615128Z","steps":["trace[378425205] 'process raft request'  (duration: 104.75709ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:52.615438Z","caller":"traceutil/trace.go:171","msg":"trace[2077721423] transaction","detail":"{read_only:false; response_revision:25512; number_of_response:1; }","duration":"103.935485ms","start":"2026-05-04T12:18:52.511467Z","end":"2026-05-04T12:18:52.615402Z","steps":["trace[2077721423] 'process raft request'  (duration: 103.602778ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:57.875538Z","caller":"traceutil/trace.go:171","msg":"trace[1999907824] transaction","detail":"{read_only:false; response_revision:25554; number_of_response:1; }","duration":"228.606076ms","start":"2026-05-04T12:18:57.646903Z","end":"2026-05-04T12:18:57.875509Z","steps":["trace[1999907824] 'process raft request'  (duration: 228.419823ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:58.007243Z","caller":"traceutil/trace.go:171","msg":"trace[347483331] transaction","detail":"{read_only:false; response_revision:25555; number_of_response:1; }","duration":"288.863674ms","start":"2026-05-04T12:18:57.718348Z","end":"2026-05-04T12:18:58.007211Z","steps":["trace[347483331] 'process raft request'  (duration: 287.03535ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.351704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.846065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:18:58.351789Z","caller":"traceutil/trace.go:171","msg":"trace[359538106] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:25556; }","duration":"140.004589ms","start":"2026-05-04T12:18:58.211766Z","end":"2026-05-04T12:18:58.351771Z","steps":["trace[359538106] 'count revisions from in-memory index tree'  (duration: 139.734332ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:58.351945Z","caller":"traceutil/trace.go:171","msg":"trace[1582258040] linearizableReadLoop","detail":"{readStateIndex:26397; appliedIndex:26396; }","duration":"111.226421ms","start":"2026-05-04T12:18:58.240681Z","end":"2026-05-04T12:18:58.351907Z","steps":["trace[1582258040] 'read index received'  (duration: 107.904179ms)","trace[1582258040] 'applied index is now lower than readState.Index'  (duration: 3.321132ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:18:58.352001Z","caller":"traceutil/trace.go:171","msg":"trace[1624772937] transaction","detail":"{read_only:false; response_revision:25557; number_of_response:1; }","duration":"128.644577ms","start":"2026-05-04T12:18:58.223339Z","end":"2026-05-04T12:18:58.351984Z","steps":["trace[1624772937] 'process raft request'  (duration: 125.258633ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.35209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.378754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:18:58.352128Z","caller":"traceutil/trace.go:171","msg":"trace[928464546] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:25557; }","duration":"111.469555ms","start":"2026-05-04T12:18:58.240647Z","end":"2026-05-04T12:18:58.352117Z","steps":["trace[928464546] 'agreement among raft nodes before linearized reading'  (duration: 111.365593ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:58.529315Z","caller":"traceutil/trace.go:171","msg":"trace[198876374] transaction","detail":"{read_only:false; response_revision:25558; number_of_response:1; }","duration":"161.827057ms","start":"2026-05-04T12:18:58.367446Z","end":"2026-05-04T12:18:58.529273Z","steps":["trace[198876374] 'process raft request'  (duration: 142.407814ms)","trace[198876374] 'compare'  (duration: 19.231359ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:18:58.820609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.869863ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507649032 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25544 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T12:18:58.82122Z","caller":"traceutil/trace.go:171","msg":"trace[1287334453] transaction","detail":"{read_only:false; response_revision:25559; number_of_response:1; }","duration":"452.870382ms","start":"2026-05-04T12:18:58.368318Z","end":"2026-05-04T12:18:58.821188Z","steps":["trace[1287334453] 'process raft request'  (duration: 348.292615ms)","trace[1287334453] 'compare'  (duration: 103.15707ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:18:58.821371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:18:58.368299Z","time spent":"452.985555ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25544 > 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-04T12:18:58.821581Z","caller":"traceutil/trace.go:171","msg":"trace[1126676919] transaction","detail":"{read_only:false; response_revision:25560; number_of_response:1; }","duration":"453.062215ms","start":"2026-05-04T12:18:58.368485Z","end":"2026-05-04T12:18:58.821547Z","steps":["trace[1126676919] 'process raft request'  (duration: 452.347882ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.821839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:18:58.368445Z","time spent":"453.33366ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25545 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T12:18:58.833622Z","caller":"traceutil/trace.go:171","msg":"trace[812683034] linearizableReadLoop","detail":"{readStateIndex:26402; appliedIndex:26398; }","duration":"193.182024ms","start":"2026-05-04T12:18:58.640423Z","end":"2026-05-04T12:18:58.833605Z","steps":["trace[812683034] 'read index received'  (duration: 76.103594ms)","trace[812683034] 'applied index is now lower than readState.Index'  (duration: 117.07737ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:18:58.833936Z","caller":"traceutil/trace.go:171","msg":"trace[830384251] transaction","detail":"{read_only:false; response_revision:25561; number_of_response:1; }","duration":"200.47781ms","start":"2026-05-04T12:18:58.633442Z","end":"2026-05-04T12:18:58.83392Z","steps":["trace[830384251] 'process raft request'  (duration: 200.040762ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:58.83416Z","caller":"traceutil/trace.go:171","msg":"trace[1810719138] transaction","detail":"{read_only:false; response_revision:25562; number_of_response:1; }","duration":"198.394821ms","start":"2026-05-04T12:18:58.635755Z","end":"2026-05-04T12:18:58.83415Z","steps":["trace[1810719138] 'process raft request'  (duration: 197.809121ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.834444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.019569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-04T12:18:58.834525Z","caller":"traceutil/trace.go:171","msg":"trace[869466493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25562; }","duration":"194.134281ms","start":"2026-05-04T12:18:58.640379Z","end":"2026-05-04T12:18:58.834513Z","steps":["trace[869466493] 'agreement among raft nodes before linearized reading'  (duration: 193.940957ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.834773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.273817ms","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-04T12:18:58.834853Z","caller":"traceutil/trace.go:171","msg":"trace[924420560] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25562; }","duration":"192.38948ms","start":"2026-05-04T12:18:58.642449Z","end":"2026-05-04T12:18:58.834839Z","steps":["trace[924420560] 'agreement among raft nodes before linearized reading'  (duration: 192.256546ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.83548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.648507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:18:58.835576Z","caller":"traceutil/trace.go:171","msg":"trace[1603278987] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:25562; }","duration":"120.79413ms","start":"2026-05-04T12:18:58.714768Z","end":"2026-05-04T12:18:58.835562Z","steps":["trace[1603278987] 'agreement among raft nodes before linearized reading'  (duration: 120.611626ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:58.835853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.643399ms","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-04T12:18:58.836706Z","caller":"traceutil/trace.go:171","msg":"trace[1760246795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25562; }","duration":"174.516535ms","start":"2026-05-04T12:18:58.662177Z","end":"2026-05-04T12:18:58.836694Z","steps":["trace[1760246795] 'agreement among raft nodes before linearized reading'  (duration: 173.605948ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:58.968734Z","caller":"traceutil/trace.go:171","msg":"trace[1817448353] transaction","detail":"{read_only:false; response_revision:25563; number_of_response:1; }","duration":"128.405152ms","start":"2026-05-04T12:18:58.840293Z","end":"2026-05-04T12:18:58.968698Z","steps":["trace[1817448353] 'process raft request'  (duration: 124.200923ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:59.169419Z","caller":"traceutil/trace.go:171","msg":"trace[1027878801] transaction","detail":"{read_only:false; response_revision:25564; number_of_response:1; }","duration":"328.585897ms","start":"2026-05-04T12:18:58.84081Z","end":"2026-05-04T12:18:59.169396Z","steps":["trace[1027878801] 'process raft request'  (duration: 318.598719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:59.169577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:18:58.840798Z","time spent":"328.695729ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25549 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-04T12:18:59.169621Z","caller":"traceutil/trace.go:171","msg":"trace[1327311806] transaction","detail":"{read_only:false; response_revision:25565; number_of_response:1; }","duration":"328.223521ms","start":"2026-05-04T12:18:58.841375Z","end":"2026-05-04T12:18:59.169598Z","steps":["trace[1327311806] 'process raft request'  (duration: 327.943355ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:59.169651Z","caller":"traceutil/trace.go:171","msg":"trace[1642593830] transaction","detail":"{read_only:false; response_revision:25566; number_of_response:1; }","duration":"296.959745ms","start":"2026-05-04T12:18:58.872652Z","end":"2026-05-04T12:18:59.169612Z","steps":["trace[1642593830] 'process raft request'  (duration: 296.877944ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:59.169763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:18:58.841365Z","time spent":"328.313392ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25548 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-04T12:18:59.169805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.892377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-04T12:18:59.169846Z","caller":"traceutil/trace.go:171","msg":"trace[1885895644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25566; }","duration":"309.982939ms","start":"2026-05-04T12:18:58.859853Z","end":"2026-05-04T12:18:59.169836Z","steps":["trace[1885895644] 'agreement among raft nodes before linearized reading'  (duration: 309.809506ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:18:59.169613Z","caller":"traceutil/trace.go:171","msg":"trace[200500938] linearizableReadLoop","detail":"{readStateIndex:26405; appliedIndex:26402; }","duration":"309.668644ms","start":"2026-05-04T12:18:58.859916Z","end":"2026-05-04T12:18:59.169585Z","steps":["trace[200500938] 'read index received'  (duration: 104.606117ms)","trace[200500938] 'applied index is now lower than readState.Index'  (duration: 205.061717ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:18:59.169879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:18:58.859833Z","time spent":"310.038151ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-04T12:18:59.170072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.292294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-05-04T12:18:59.170114Z","caller":"traceutil/trace.go:171","msg":"trace[622649840] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:25566; }","duration":"226.383436ms","start":"2026-05-04T12:18:58.94372Z","end":"2026-05-04T12:18:59.170104Z","steps":["trace[622649840] 'agreement among raft nodes before linearized reading'  (duration: 226.238973ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:18:59.170291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.328569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:18:59.17063Z","caller":"traceutil/trace.go:171","msg":"trace[333788330] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25566; }","duration":"137.714396ms","start":"2026-05-04T12:18:59.032902Z","end":"2026-05-04T12:18:59.170617Z","steps":["trace[333788330] 'agreement among raft nodes before linearized reading'  (duration: 137.34977ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:00.18721Z","caller":"traceutil/trace.go:171","msg":"trace[1777575075] linearizableReadLoop","detail":"{readStateIndex:26412; appliedIndex:26411; }","duration":"132.994678ms","start":"2026-05-04T12:19:00.054177Z","end":"2026-05-04T12:19:00.187171Z","steps":["trace[1777575075] 'read index received'  (duration: 132.705213ms)","trace[1777575075] 'applied index is now lower than readState.Index'  (duration: 288.075µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:00.187411Z","caller":"traceutil/trace.go:171","msg":"trace[851755365] transaction","detail":"{read_only:false; response_revision:25571; number_of_response:1; }","duration":"192.458321ms","start":"2026-05-04T12:18:59.994925Z","end":"2026-05-04T12:19:00.187384Z","steps":["trace[851755365] 'process raft request'  (duration: 192.045742ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:00.187442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.243963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:19:00.187499Z","caller":"traceutil/trace.go:171","msg":"trace[935471841] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:25571; }","duration":"133.367945ms","start":"2026-05-04T12:19:00.054113Z","end":"2026-05-04T12:19:00.187481Z","steps":["trace[935471841] 'agreement among raft nodes before linearized reading'  (duration: 133.194842ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.280727Z","caller":"traceutil/trace.go:171","msg":"trace[1866071205] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"452.27733ms","start":"2026-05-04T12:19:00.828422Z","end":"2026-05-04T12:19:01.2807Z","steps":["trace[1866071205] 'process raft request'  (duration: 452.016565ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.280914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:00.828387Z","time spent":"452.424094ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25559 > 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-04T12:19:01.281105Z","caller":"traceutil/trace.go:171","msg":"trace[2097966291] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"440.133444ms","start":"2026-05-04T12:19:00.840941Z","end":"2026-05-04T12:19:01.281074Z","steps":["trace[2097966291] 'process raft request'  (duration: 439.692415ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.281142Z","caller":"traceutil/trace.go:171","msg":"trace[1715571170] linearizableReadLoop","detail":"{readStateIndex:26418; appliedIndex:26415; }","duration":"352.475364ms","start":"2026-05-04T12:19:00.928636Z","end":"2026-05-04T12:19:01.281111Z","steps":["trace[1715571170] 'read index received'  (duration: 351.832421ms)","trace[1715571170] 'applied index is now lower than readState.Index'  (duration: 641.893µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:01.281259Z","caller":"traceutil/trace.go:171","msg":"trace[1353764336] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"438.232368ms","start":"2026-05-04T12:19:00.84301Z","end":"2026-05-04T12:19:01.281242Z","steps":["trace[1353764336] 'process raft request'  (duration: 437.888452ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.281271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:00.840921Z","time spent":"440.259197ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25562 > 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-04T12:19:01.281342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:00.842995Z","time spent":"438.311009ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25561 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:01.281465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.79861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7533"}
{"level":"info","ts":"2026-05-04T12:19:01.281511Z","caller":"traceutil/trace.go:171","msg":"trace[480107422] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:25577; }","duration":"352.925732ms","start":"2026-05-04T12:19:00.928574Z","end":"2026-05-04T12:19:01.281499Z","steps":["trace[480107422] 'agreement among raft nodes before linearized reading'  (duration: 352.679837ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.281564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:00.928551Z","time spent":"353.002304ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7556,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "}
{"level":"info","ts":"2026-05-04T12:19:01.32512Z","caller":"traceutil/trace.go:171","msg":"trace[905116529] transaction","detail":"{read_only:false; response_revision:25578; number_of_response:1; }","duration":"284.654425ms","start":"2026-05-04T12:19:01.040433Z","end":"2026-05-04T12:19:01.325087Z","steps":["trace[905116529] 'process raft request'  (duration: 282.76323ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.325424Z","caller":"traceutil/trace.go:171","msg":"trace[1592476137] transaction","detail":"{read_only:false; response_revision:25579; number_of_response:1; }","duration":"149.616999ms","start":"2026-05-04T12:19:01.175763Z","end":"2026-05-04T12:19:01.32538Z","steps":["trace[1592476137] 'process raft request'  (duration: 149.254732ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.32551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.754466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T12:19:01.325543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.486503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-04T12:19:01.325598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.289842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-04T12:19:01.325609Z","caller":"traceutil/trace.go:171","msg":"trace[511898101] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:25579; }","duration":"122.96418ms","start":"2026-05-04T12:19:01.202617Z","end":"2026-05-04T12:19:01.325581Z","steps":["trace[511898101] 'agreement among raft nodes before linearized reading'  (duration: 122.715775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.325635Z","caller":"traceutil/trace.go:171","msg":"trace[417210876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25579; }","duration":"352.639997ms","start":"2026-05-04T12:19:00.972971Z","end":"2026-05-04T12:19:01.325611Z","steps":["trace[417210876] 'agreement among raft nodes before linearized reading'  (duration: 352.31837ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.325643Z","caller":"traceutil/trace.go:171","msg":"trace[1664787777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25579; }","duration":"103.410764ms","start":"2026-05-04T12:19:01.222219Z","end":"2026-05-04T12:19:01.32563Z","steps":["trace[1664787777] 'agreement among raft nodes before linearized reading'  (duration: 103.23573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.325693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:00.972943Z","time spent":"352.736108ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-04T12:19:01.325915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.068884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-04T12:19:01.325941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.889152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-04T12:19:01.325934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.767589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:19:01.32597Z","caller":"traceutil/trace.go:171","msg":"trace[1736871816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25579; }","duration":"151.949682ms","start":"2026-05-04T12:19:01.174011Z","end":"2026-05-04T12:19:01.325961Z","steps":["trace[1736871816] 'agreement among raft nodes before linearized reading'  (duration: 151.773559ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.325959Z","caller":"traceutil/trace.go:171","msg":"trace[784390905] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25579; }","duration":"160.216277ms","start":"2026-05-04T12:19:01.165726Z","end":"2026-05-04T12:19:01.325943Z","steps":["trace[784390905] 'agreement among raft nodes before linearized reading'  (duration: 160.033484ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.325935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.767511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-04T12:19:01.326087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.008681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:19:01.326146Z","caller":"traceutil/trace.go:171","msg":"trace[95597489] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:25579; }","duration":"278.105932ms","start":"2026-05-04T12:19:01.048027Z","end":"2026-05-04T12:19:01.326133Z","steps":["trace[95597489] 'agreement among raft nodes before linearized reading'  (duration: 277.98975ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.326161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.056613ms","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-04T12:19:01.326193Z","caller":"traceutil/trace.go:171","msg":"trace[2005114705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25579; }","duration":"153.134734ms","start":"2026-05-04T12:19:01.173048Z","end":"2026-05-04T12:19:01.326183Z","steps":["trace[2005114705] 'agreement among raft nodes before linearized reading'  (duration: 153.046753ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.326223Z","caller":"traceutil/trace.go:171","msg":"trace[206958356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25579; }","duration":"103.985475ms","start":"2026-05-04T12:19:01.222056Z","end":"2026-05-04T12:19:01.326041Z","steps":["trace[206958356] 'agreement among raft nodes before linearized reading'  (duration: 103.601758ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.325991Z","caller":"traceutil/trace.go:171","msg":"trace[1909929044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25579; }","duration":"205.872631ms","start":"2026-05-04T12:19:01.120104Z","end":"2026-05-04T12:19:01.325977Z","steps":["trace[1909929044] 'agreement among raft nodes before linearized reading'  (duration: 205.745678ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.672359Z","caller":"traceutil/trace.go:171","msg":"trace[2074501203] transaction","detail":"{read_only:false; response_revision:25581; number_of_response:1; }","duration":"340.948877ms","start":"2026-05-04T12:19:01.331375Z","end":"2026-05-04T12:19:01.672323Z","steps":["trace[2074501203] 'process raft request'  (duration: 340.673032ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.672435Z","caller":"traceutil/trace.go:171","msg":"trace[916201605] transaction","detail":"{read_only:false; response_revision:25582; number_of_response:1; }","duration":"340.864436ms","start":"2026-05-04T12:19:01.331521Z","end":"2026-05-04T12:19:01.672386Z","steps":["trace[916201605] 'process raft request'  (duration: 340.710163ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.672531Z","caller":"traceutil/trace.go:171","msg":"trace[1581484305] transaction","detail":"{read_only:false; response_revision:25583; number_of_response:1; }","duration":"340.925967ms","start":"2026-05-04T12:19:01.331592Z","end":"2026-05-04T12:19:01.672518Z","steps":["trace[1581484305] 'process raft request'  (duration: 340.691022ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.672552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:01.331349Z","time spent":"341.09447ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25565 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:01.672618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:01.331578Z","time spent":"340.984918ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25564 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:01.672635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:01.331498Z","time spent":"341.016669ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25568 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-04T12:19:01.672719Z","caller":"traceutil/trace.go:171","msg":"trace[844927779] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"341.046639ms","start":"2026-05-04T12:19:01.331667Z","end":"2026-05-04T12:19:01.672713Z","steps":["trace[844927779] 'process raft request'  (duration: 340.655752ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:01.672756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:01.331636Z","time spent":"341.10116ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25563 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:01.672909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.408598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:19:01.67294Z","caller":"traceutil/trace.go:171","msg":"trace[1122925752] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:25584; }","duration":"224.441899ms","start":"2026-05-04T12:19:01.448488Z","end":"2026-05-04T12:19:01.67293Z","steps":["trace[1122925752] 'agreement among raft nodes before linearized reading'  (duration: 224.382108ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:01.673205Z","caller":"traceutil/trace.go:171","msg":"trace[206237513] linearizableReadLoop","detail":"{readStateIndex:26425; appliedIndex:26421; }","duration":"223.908049ms","start":"2026-05-04T12:19:01.448503Z","end":"2026-05-04T12:19:01.672411Z","steps":["trace[206237513] 'read index received'  (duration: 223.484401ms)","trace[206237513] 'applied index is now lower than readState.Index'  (duration: 422.818µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:01.673381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.807315ms","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-04T12:19:01.673425Z","caller":"traceutil/trace.go:171","msg":"trace[996820199] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25584; }","duration":"109.910367ms","start":"2026-05-04T12:19:01.563502Z","end":"2026-05-04T12:19:01.673412Z","steps":["trace[996820199] 'agreement among raft nodes before linearized reading'  (duration: 109.815955ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.02353Z","caller":"traceutil/trace.go:171","msg":"trace[1208965065] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"198.766718ms","start":"2026-05-04T12:19:01.824742Z","end":"2026-05-04T12:19:02.023509Z","steps":["trace[1208965065] 'process raft request'  (duration: 198.523204ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.023524Z","caller":"traceutil/trace.go:171","msg":"trace[1741145797] linearizableReadLoop","detail":"{readStateIndex:26426; appliedIndex:26425; }","duration":"104.596177ms","start":"2026-05-04T12:19:01.918891Z","end":"2026-05-04T12:19:02.023487Z","steps":["trace[1741145797] 'read index received'  (duration: 104.402043ms)","trace[1741145797] 'applied index is now lower than readState.Index'  (duration: 192.674µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:02.023662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.7439ms","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-04T12:19:02.023723Z","caller":"traceutil/trace.go:171","msg":"trace[1103083107] 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:25585; }","duration":"104.876802ms","start":"2026-05-04T12:19:01.918828Z","end":"2026-05-04T12:19:02.023705Z","steps":["trace[1103083107] 'agreement among raft nodes before linearized reading'  (duration: 104.75252ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.156715Z","caller":"traceutil/trace.go:171","msg":"trace[1202226875] linearizableReadLoop","detail":"{readStateIndex:26427; appliedIndex:26426; }","duration":"133.016718ms","start":"2026-05-04T12:19:02.023675Z","end":"2026-05-04T12:19:02.156692Z","steps":["trace[1202226875] 'read index received'  (duration: 132.594981ms)","trace[1202226875] 'applied index is now lower than readState.Index'  (duration: 420.947µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:02.15687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.307147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-04T12:19:02.156947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.795394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18621"}
{"level":"info","ts":"2026-05-04T12:19:02.156991Z","caller":"traceutil/trace.go:171","msg":"trace[1419159415] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:25586; }","duration":"124.886576ms","start":"2026-05-04T12:19:02.032087Z","end":"2026-05-04T12:19:02.156974Z","steps":["trace[1419159415] 'agreement among raft nodes before linearized reading'  (duration: 124.739974ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.156998Z","caller":"traceutil/trace.go:171","msg":"trace[2103426761] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25586; }","duration":"162.482479ms","start":"2026-05-04T12:19:01.994484Z","end":"2026-05-04T12:19:02.156966Z","steps":["trace[2103426761] 'agreement among raft nodes before linearized reading'  (duration: 162.245965ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:02.157047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.362739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-05-04T12:19:02.157136Z","caller":"traceutil/trace.go:171","msg":"trace[1582361453] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0; range_end:; response_count:1; response_revision:25586; }","duration":"168.516082ms","start":"2026-05-04T12:19:01.988598Z","end":"2026-05-04T12:19:02.157114Z","steps":["trace[1582361453] 'agreement among raft nodes before linearized reading'  (duration: 168.216836ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.157548Z","caller":"traceutil/trace.go:171","msg":"trace[943345492] transaction","detail":"{read_only:false; response_revision:25586; number_of_response:1; }","duration":"202.159452ms","start":"2026-05-04T12:19:01.955316Z","end":"2026-05-04T12:19:02.157476Z","steps":["trace[943345492] 'process raft request'  (duration: 201.204614ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.557411Z","caller":"traceutil/trace.go:171","msg":"trace[962340676] transaction","detail":"{read_only:false; response_revision:25587; number_of_response:1; }","duration":"131.742115ms","start":"2026-05-04T12:19:02.425633Z","end":"2026-05-04T12:19:02.557375Z","steps":["trace[962340676] 'process raft request'  (duration: 130.93487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:02.752098Z","caller":"traceutil/trace.go:171","msg":"trace[1466993744] transaction","detail":"{read_only:false; response_revision:25588; number_of_response:1; }","duration":"183.272568ms","start":"2026-05-04T12:19:02.568796Z","end":"2026-05-04T12:19:02.752069Z","steps":["trace[1466993744] 'process raft request'  (duration: 183.099655ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:08.278823Z","caller":"traceutil/trace.go:171","msg":"trace[48185104] transaction","detail":"{read_only:false; response_revision:25627; number_of_response:1; }","duration":"102.781763ms","start":"2026-05-04T12:19:08.176007Z","end":"2026-05-04T12:19:08.278789Z","steps":["trace[48185104] 'process raft request'  (duration: 102.592149ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:08.562616Z","caller":"traceutil/trace.go:171","msg":"trace[783771767] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"192.130594ms","start":"2026-05-04T12:19:08.370446Z","end":"2026-05-04T12:19:08.562577Z","steps":["trace[783771767] 'process raft request'  (duration: 191.881249ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:08.878874Z","caller":"traceutil/trace.go:171","msg":"trace[1544108563] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"302.05007ms","start":"2026-05-04T12:19:08.576762Z","end":"2026-05-04T12:19:08.878812Z","steps":["trace[1544108563] 'process raft request'  (duration: 228.168288ms)","trace[1544108563] 'compare'  (duration: 73.592327ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:08.879093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:08.576729Z","time spent":"302.244084ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25615 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-04T12:19:09.090757Z","caller":"traceutil/trace.go:171","msg":"trace[898933440] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"320.155558ms","start":"2026-05-04T12:19:08.770571Z","end":"2026-05-04T12:19:09.090727Z","steps":["trace[898933440] 'process raft request'  (duration: 297.402593ms)","trace[898933440] 'compare'  (duration: 22.627263ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:09.090912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:08.770536Z","time spent":"320.293062ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25616 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-04T12:19:09.636926Z","caller":"traceutil/trace.go:171","msg":"trace[2115769969] transaction","detail":"{read_only:false; response_revision:25631; number_of_response:1; }","duration":"805.610381ms","start":"2026-05-04T12:19:08.831271Z","end":"2026-05-04T12:19:09.636882Z","steps":["trace[2115769969] 'process raft request'  (duration: 802.575433ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:09.636988Z","caller":"traceutil/trace.go:171","msg":"trace[1113474867] linearizableReadLoop","detail":"{readStateIndex:26474; appliedIndex:26471; }","duration":"600.265439ms","start":"2026-05-04T12:19:09.036696Z","end":"2026-05-04T12:19:09.636961Z","steps":["trace[1113474867] 'read index received'  (duration: 31.290855ms)","trace[1113474867] 'applied index is now lower than readState.Index'  (duration: 568.973194ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:09.637019Z","caller":"traceutil/trace.go:171","msg":"trace[1707522850] transaction","detail":"{read_only:false; response_revision:25632; number_of_response:1; }","duration":"698.413205ms","start":"2026-05-04T12:19:08.938582Z","end":"2026-05-04T12:19:09.636995Z","steps":["trace[1707522850] 'process raft request'  (duration: 698.240922ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.637172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:08.938549Z","time spent":"698.520007ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25617 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:09.63721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.464742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:19:09.637366Z","caller":"traceutil/trace.go:171","msg":"trace[1827386757] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:25632; }","duration":"600.663366ms","start":"2026-05-04T12:19:09.036642Z","end":"2026-05-04T12:19:09.637305Z","steps":["trace[1827386757] 'agreement among raft nodes before linearized reading'  (duration: 600.441332ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.637131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:08.831241Z","time spent":"805.776274ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25578 > 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":"warn","ts":"2026-05-04T12:19:09.637425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.036617Z","time spent":"600.794788ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true "}
{"level":"info","ts":"2026-05-04T12:19:09.937029Z","caller":"traceutil/trace.go:171","msg":"trace[902155047] transaction","detail":"{read_only:false; response_revision:25633; number_of_response:1; }","duration":"629.581487ms","start":"2026-05-04T12:19:09.307416Z","end":"2026-05-04T12:19:09.936998Z","steps":["trace[902155047] 'process raft request'  (duration: 628.508857ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.937363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.307375Z","time spent":"629.876533ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25618 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-04T12:19:09.937454Z","caller":"traceutil/trace.go:171","msg":"trace[575934742] linearizableReadLoop","detail":"{readStateIndex:26478; appliedIndex:26474; }","duration":"300.372858ms","start":"2026-05-04T12:19:09.637052Z","end":"2026-05-04T12:19:09.937425Z","steps":["trace[575934742] 'read index received'  (duration: 298.8434ms)","trace[575934742] 'applied index is now lower than readState.Index'  (duration: 1.528128ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:09.93782Z","caller":"traceutil/trace.go:171","msg":"trace[841424472] transaction","detail":"{read_only:false; response_revision:25635; number_of_response:1; }","duration":"626.117983ms","start":"2026-05-04T12:19:09.31167Z","end":"2026-05-04T12:19:09.937788Z","steps":["trace[841424472] 'process raft request'  (duration: 625.609073ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.938029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.938548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T12:19:09.938064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.358886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-04T12:19:09.938094Z","caller":"traceutil/trace.go:171","msg":"trace[748200250] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:25636; }","duration":"858.432278ms","start":"2026-05-04T12:19:09.079652Z","end":"2026-05-04T12:19:09.938084Z","steps":["trace[748200250] 'agreement among raft nodes before linearized reading'  (duration: 858.258145ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:09.938099Z","caller":"traceutil/trace.go:171","msg":"trace[645560702] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25636; }","duration":"588.089211ms","start":"2026-05-04T12:19:09.349989Z","end":"2026-05-04T12:19:09.938079Z","steps":["trace[645560702] 'agreement among raft nodes before linearized reading'  (duration: 587.965019ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.93812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.079628Z","time spent":"858.487798ms","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.227\" "}
{"level":"warn","ts":"2026-05-04T12:19:09.938144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.349962Z","time spent":"588.171053ms","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-05-04T12:19:09.938144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.991942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T12:19:09.938063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.311653Z","time spent":"626.361658ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25620 > 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-04T12:19:09.938226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.433244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-04T12:19:09.938308Z","caller":"traceutil/trace.go:171","msg":"trace[1838698130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25636; }","duration":"818.215067ms","start":"2026-05-04T12:19:09.119968Z","end":"2026-05-04T12:19:09.938183Z","steps":["trace[1838698130] 'agreement among raft nodes before linearized reading'  (duration: 818.011883ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:09.938326Z","caller":"traceutil/trace.go:171","msg":"trace[404138888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25636; }","duration":"235.599947ms","start":"2026-05-04T12:19:09.702705Z","end":"2026-05-04T12:19:09.938305Z","steps":["trace[404138888] 'agreement among raft nodes before linearized reading'  (duration: 235.272431ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.938293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.522915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-04T12:19:09.938261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.982289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-04T12:19:09.938407Z","caller":"traceutil/trace.go:171","msg":"trace[1743016058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25636; }","duration":"519.180882ms","start":"2026-05-04T12:19:09.419215Z","end":"2026-05-04T12:19:09.938396Z","steps":["trace[1743016058] 'agreement among raft nodes before linearized reading'  (duration: 518.53037ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:09.938419Z","caller":"traceutil/trace.go:171","msg":"trace[2126700263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25636; }","duration":"228.693367ms","start":"2026-05-04T12:19:09.709702Z","end":"2026-05-04T12:19:09.938396Z","steps":["trace[2126700263] 'agreement among raft nodes before linearized reading'  (duration: 228.316101ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:09.937837Z","caller":"traceutil/trace.go:171","msg":"trace[368185504] transaction","detail":"{read_only:false; response_revision:25634; number_of_response:1; }","duration":"628.630849ms","start":"2026-05-04T12:19:09.309172Z","end":"2026-05-04T12:19:09.937802Z","steps":["trace[368185504] 'process raft request'  (duration: 627.738383ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.938552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.660358ms","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-04T12:19:09.93856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.419175Z","time spent":"519.262313ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-04T12:19:09.938573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.868454ms","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-04T12:19:09.938584Z","caller":"traceutil/trace.go:171","msg":"trace[260505645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25636; }","duration":"235.75214ms","start":"2026-05-04T12:19:09.702825Z","end":"2026-05-04T12:19:09.938577Z","steps":["trace[260505645] 'agreement among raft nodes before linearized reading'  (duration: 235.671008ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:09.938603Z","caller":"traceutil/trace.go:171","msg":"trace[1606426006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25636; }","duration":"235.007166ms","start":"2026-05-04T12:19:09.703586Z","end":"2026-05-04T12:19:09.938593Z","steps":["trace[1606426006] 'agreement among raft nodes before linearized reading'  (duration: 234.909234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.938649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.309133Z","time spent":"629.402314ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25619 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:09.938169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.80264ms","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-04T12:19:09.938766Z","caller":"traceutil/trace.go:171","msg":"trace[1965199906] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25636; }","duration":"484.474503ms","start":"2026-05-04T12:19:09.45427Z","end":"2026-05-04T12:19:09.938745Z","steps":["trace[1965199906] 'agreement among raft nodes before linearized reading'  (duration: 483.592667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.93883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.454245Z","time spent":"484.566854ms","remote":"127.0.0.1:37138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-04T12:19:09.937861Z","caller":"traceutil/trace.go:171","msg":"trace[611081133] transaction","detail":"{read_only:false; response_revision:25636; number_of_response:1; }","duration":"579.823017ms","start":"2026-05-04T12:19:09.358015Z","end":"2026-05-04T12:19:09.937838Z","steps":["trace[611081133] 'process raft request'  (duration: 579.357718ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:09.938479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.119944Z","time spent":"818.524492ms","remote":"127.0.0.1:36950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T12:19:09.938975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.357987Z","time spent":"580.894256ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25621 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-04T12:19:10.243836Z","caller":"traceutil/trace.go:171","msg":"trace[692280404] transaction","detail":"{read_only:false; response_revision:25637; number_of_response:1; }","duration":"299.93485ms","start":"2026-05-04T12:19:09.943862Z","end":"2026-05-04T12:19:10.243796Z","steps":["trace[692280404] 'process raft request'  (duration: 273.874183ms)","trace[692280404] 'compare'  (duration: 25.699981ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:10.243995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.943849Z","time spent":"300.061182ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25624 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-04T12:19:10.244195Z","caller":"traceutil/trace.go:171","msg":"trace[556661163] transaction","detail":"{read_only:false; response_revision:25638; number_of_response:1; }","duration":"299.839409ms","start":"2026-05-04T12:19:09.944328Z","end":"2026-05-04T12:19:10.244167Z","steps":["trace[556661163] 'process raft request'  (duration: 299.382931ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:10.244434Z","caller":"traceutil/trace.go:171","msg":"trace[386944996] transaction","detail":"{read_only:false; response_revision:25639; number_of_response:1; }","duration":"299.427871ms","start":"2026-05-04T12:19:09.944991Z","end":"2026-05-04T12:19:10.244419Z","steps":["trace[386944996] 'process raft request'  (duration: 299.055894ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:10.244469Z","caller":"traceutil/trace.go:171","msg":"trace[23470524] transaction","detail":"{read_only:false; response_revision:25640; number_of_response:1; }","duration":"299.036524ms","start":"2026-05-04T12:19:09.945411Z","end":"2026-05-04T12:19:10.244447Z","steps":["trace[23470524] 'process raft request'  (duration: 298.899911ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:10.244579Z","caller":"traceutil/trace.go:171","msg":"trace[1849993686] transaction","detail":"{read_only:false; response_revision:25641; number_of_response:1; }","duration":"298.82678ms","start":"2026-05-04T12:19:09.945737Z","end":"2026-05-04T12:19:10.244564Z","steps":["trace[1849993686] 'process raft request'  (duration: 298.664066ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:10.244591Z","caller":"traceutil/trace.go:171","msg":"trace[2123095853] linearizableReadLoop","detail":"{readStateIndex:26484; appliedIndex:26479; }","duration":"283.683647ms","start":"2026-05-04T12:19:09.960875Z","end":"2026-05-04T12:19:10.244559Z","steps":["trace[2123095853] 'read index received'  (duration: 256.815424ms)","trace[2123095853] 'applied index is now lower than readState.Index'  (duration: 26.866873ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:10.244721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.375333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T12:19:10.244737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.468691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-05-04T12:19:10.245478Z","caller":"traceutil/trace.go:171","msg":"trace[43129387] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:25641; }","duration":"285.236525ms","start":"2026-05-04T12:19:09.960224Z","end":"2026-05-04T12:19:10.245461Z","steps":["trace[43129387] 'agreement among raft nodes before linearized reading'  (duration: 284.352059ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:10.244789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.261646ms","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-04T12:19:10.245583Z","caller":"traceutil/trace.go:171","msg":"trace[816772402] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25641; }","duration":"302.09463ms","start":"2026-05-04T12:19:09.943476Z","end":"2026-05-04T12:19:10.245571Z","steps":["trace[816772402] 'agreement among raft nodes before linearized reading'  (duration: 301.186494ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:10.245615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.943458Z","time spent":"302.148311ms","remote":"127.0.0.1:37138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-04T12:19:10.24588Z","caller":"traceutil/trace.go:171","msg":"trace[161704358] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25641; }","duration":"297.816361ms","start":"2026-05-04T12:19:09.947304Z","end":"2026-05-04T12:19:10.24512Z","steps":["trace[161704358] 'agreement among raft nodes before linearized reading'  (duration: 297.277492ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:10.265142Z","caller":"traceutil/trace.go:171","msg":"trace[1881519913] transaction","detail":"{read_only:false; response_revision:25642; number_of_response:1; }","duration":"303.15992ms","start":"2026-05-04T12:19:09.961957Z","end":"2026-05-04T12:19:10.265117Z","steps":["trace[1881519913] 'process raft request'  (duration: 302.843554ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:10.265308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:09.961884Z","time spent":"303.327034ms","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.227\" mod_revision:25569 > success:<request_put:<key:\"/registry/masterleases/199.204.45.227\" value_size:68 lease:2432680414652873396 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.227\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:10.265331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.066935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:180"}
{"level":"info","ts":"2026-05-04T12:19:10.265397Z","caller":"traceutil/trace.go:171","msg":"trace[1100515411] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:25643; }","duration":"275.188007ms","start":"2026-05-04T12:19:09.990193Z","end":"2026-05-04T12:19:10.265381Z","steps":["trace[1100515411] 'agreement among raft nodes before linearized reading'  (duration: 274.971843ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:12.702373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.870829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e3baee49-afd1-4884-ba8b-b7c4ca2ebaaf\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-05-04T12:19:12.702471Z","caller":"traceutil/trace.go:171","msg":"trace[1025777692] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e3baee49-afd1-4884-ba8b-b7c4ca2ebaaf; range_end:; response_count:1; response_revision:25719; }","duration":"193.396068ms","start":"2026-05-04T12:19:12.509051Z","end":"2026-05-04T12:19:12.702447Z","steps":["trace[1025777692] 'range keys from in-memory index tree'  (duration: 192.646544ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:13.02587Z","caller":"traceutil/trace.go:171","msg":"trace[1869066063] transaction","detail":"{read_only:false; response_revision:25720; number_of_response:1; }","duration":"256.740133ms","start":"2026-05-04T12:19:12.769099Z","end":"2026-05-04T12:19:13.025839Z","steps":["trace[1869066063] 'process raft request'  (duration: 256.538749ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:13.042984Z","caller":"traceutil/trace.go:171","msg":"trace[1748677333] transaction","detail":"{read_only:false; response_revision:25721; number_of_response:1; }","duration":"152.828139ms","start":"2026-05-04T12:19:12.890141Z","end":"2026-05-04T12:19:13.042969Z","steps":["trace[1748677333] 'process raft request'  (duration: 152.644486ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:20.221192Z","caller":"traceutil/trace.go:171","msg":"trace[1282176867] transaction","detail":"{read_only:false; response_revision:25793; number_of_response:1; }","duration":"235.900423ms","start":"2026-05-04T12:19:19.985264Z","end":"2026-05-04T12:19:20.221164Z","steps":["trace[1282176867] 'process raft request'  (duration: 235.660689ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:20.221409Z","caller":"traceutil/trace.go:171","msg":"trace[1540778198] linearizableReadLoop","detail":"{readStateIndex:26642; appliedIndex:26638; }","duration":"208.364998ms","start":"2026-05-04T12:19:20.013022Z","end":"2026-05-04T12:19:20.221387Z","steps":["trace[1540778198] 'read index received'  (duration: 61.077303ms)","trace[1540778198] 'applied index is now lower than readState.Index'  (duration: 147.286925ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:20.221425Z","caller":"traceutil/trace.go:171","msg":"trace[2080298084] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"234.796592ms","start":"2026-05-04T12:19:19.986594Z","end":"2026-05-04T12:19:20.221391Z","steps":["trace[2080298084] 'process raft request'  (duration: 234.522917ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:20.221467Z","caller":"traceutil/trace.go:171","msg":"trace[1506446627] transaction","detail":"{read_only:false; response_revision:25795; number_of_response:1; }","duration":"233.797594ms","start":"2026-05-04T12:19:19.987644Z","end":"2026-05-04T12:19:20.221441Z","steps":["trace[1506446627] 'process raft request'  (duration: 233.659432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.221554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.518891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:19:20.221589Z","caller":"traceutil/trace.go:171","msg":"trace[1238858932] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:25795; }","duration":"208.573962ms","start":"2026-05-04T12:19:20.013005Z","end":"2026-05-04T12:19:20.221579Z","steps":["trace[1238858932] 'agreement among raft nodes before linearized reading'  (duration: 208.47853ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.530035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.513794ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507649610 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:25739 > 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-04T12:19:20.530196Z","caller":"traceutil/trace.go:171","msg":"trace[2101650020] transaction","detail":"{read_only:false; response_revision:25797; number_of_response:1; }","duration":"214.321679ms","start":"2026-05-04T12:19:20.315866Z","end":"2026-05-04T12:19:20.530187Z","steps":["trace[2101650020] 'process raft request'  (duration: 214.276578ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:20.530197Z","caller":"traceutil/trace.go:171","msg":"trace[393519996] transaction","detail":"{read_only:false; response_revision:25796; number_of_response:1; }","duration":"249.999116ms","start":"2026-05-04T12:19:20.280157Z","end":"2026-05-04T12:19:20.530156Z","steps":["trace[393519996] 'process raft request'  (duration: 121.271908ms)","trace[393519996] 'compare'  (duration: 128.378491ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:20.530262Z","caller":"traceutil/trace.go:171","msg":"trace[390974048] linearizableReadLoop","detail":"{readStateIndex:26643; appliedIndex:26642; }","duration":"242.136259ms","start":"2026-05-04T12:19:20.288089Z","end":"2026-05-04T12:19:20.530225Z","steps":["trace[390974048] 'read index received'  (duration: 113.34019ms)","trace[390974048] 'applied index is now lower than readState.Index'  (duration: 128.794839ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:20.530454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.333503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:19:20.530504Z","caller":"traceutil/trace.go:171","msg":"trace[1916476549] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25797; }","duration":"242.437085ms","start":"2026-05-04T12:19:20.288054Z","end":"2026-05-04T12:19:20.530491Z","steps":["trace[1916476549] 'agreement among raft nodes before linearized reading'  (duration: 242.325733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.530558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.412405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-04T12:19:20.530583Z","caller":"traceutil/trace.go:171","msg":"trace[294142028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25797; }","duration":"241.468407ms","start":"2026-05-04T12:19:20.289108Z","end":"2026-05-04T12:19:20.530576Z","steps":["trace[294142028] 'agreement among raft nodes before linearized reading'  (duration: 241.367295ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.530644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.748318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-04T12:19:20.530698Z","caller":"traceutil/trace.go:171","msg":"trace[1203965881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25797; }","duration":"237.814519ms","start":"2026-05-04T12:19:20.292872Z","end":"2026-05-04T12:19:20.530686Z","steps":["trace[1203965881] 'agreement among raft nodes before linearized reading'  (duration: 237.689136ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.530712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.824727ms","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-04T12:19:20.53073Z","caller":"traceutil/trace.go:171","msg":"trace[1823479762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25797; }","duration":"238.851677ms","start":"2026-05-04T12:19:20.291874Z","end":"2026-05-04T12:19:20.530725Z","steps":["trace[1823479762] 'agreement among raft nodes before linearized reading'  (duration: 238.793676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.530815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.312104ms","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-04T12:19:20.530836Z","caller":"traceutil/trace.go:171","msg":"trace[378764265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25797; }","duration":"241.363004ms","start":"2026-05-04T12:19:20.289468Z","end":"2026-05-04T12:19:20.530831Z","steps":["trace[378764265] 'agreement among raft nodes before linearized reading'  (duration: 241.313763ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.530912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.948465ms","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-04T12:19:20.530931Z","caller":"traceutil/trace.go:171","msg":"trace[366019494] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25797; }","duration":"234.985506ms","start":"2026-05-04T12:19:20.295941Z","end":"2026-05-04T12:19:20.530926Z","steps":["trace[366019494] 'agreement among raft nodes before linearized reading'  (duration: 234.937215ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:20.88296Z","caller":"traceutil/trace.go:171","msg":"trace[1576261307] linearizableReadLoop","detail":"{readStateIndex:26645; appliedIndex:26644; }","duration":"347.98934ms","start":"2026-05-04T12:19:20.53494Z","end":"2026-05-04T12:19:20.882929Z","steps":["trace[1576261307] 'read index received'  (duration: 347.833458ms)","trace[1576261307] 'applied index is now lower than readState.Index'  (duration: 154.572µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:20.882993Z","caller":"traceutil/trace.go:171","msg":"trace[286391670] transaction","detail":"{read_only:false; response_revision:25798; number_of_response:1; }","duration":"348.147133ms","start":"2026-05-04T12:19:20.534821Z","end":"2026-05-04T12:19:20.882968Z","steps":["trace[286391670] 'process raft request'  (duration: 347.904099ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.883151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.534805Z","time spent":"348.247175ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25775 > 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-04T12:19:20.883218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.252985ms","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-04T12:19:20.883297Z","caller":"traceutil/trace.go:171","msg":"trace[1432608731] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25798; }","duration":"348.376727ms","start":"2026-05-04T12:19:20.534903Z","end":"2026-05-04T12:19:20.88328Z","steps":["trace[1432608731] 'agreement among raft nodes before linearized reading'  (duration: 348.137422ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.883337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.534888Z","time spent":"348.441789ms","remote":"127.0.0.1:37138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-04T12:19:20.901235Z","caller":"traceutil/trace.go:171","msg":"trace[120074720] transaction","detail":"{read_only:false; response_revision:25799; number_of_response:1; }","duration":"366.031468ms","start":"2026-05-04T12:19:20.535188Z","end":"2026-05-04T12:19:20.901219Z","steps":["trace[120074720] 'process raft request'  (duration: 365.881415ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.901369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.535168Z","time spent":"366.14716ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25777 > 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-04T12:19:20.901485Z","caller":"traceutil/trace.go:171","msg":"trace[1065751509] transaction","detail":"{read_only:false; response_revision:25801; number_of_response:1; }","duration":"363.891417ms","start":"2026-05-04T12:19:20.537582Z","end":"2026-05-04T12:19:20.901473Z","steps":["trace[1065751509] 'process raft request'  (duration: 363.790465ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.901565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.537573Z","time spent":"363.939278ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25774 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-04T12:19:20.901537Z","caller":"traceutil/trace.go:171","msg":"trace[177298129] transaction","detail":"{read_only:false; response_revision:25800; number_of_response:1; }","duration":"366.14681ms","start":"2026-05-04T12:19:20.535356Z","end":"2026-05-04T12:19:20.901503Z","steps":["trace[177298129] 'process raft request'  (duration: 365.821334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:20.90157Z","caller":"traceutil/trace.go:171","msg":"trace[775996696] transaction","detail":"{read_only:false; response_revision:25802; number_of_response:1; }","duration":"363.897277ms","start":"2026-05-04T12:19:20.537635Z","end":"2026-05-04T12:19:20.901533Z","steps":["trace[775996696] 'process raft request'  (duration: 363.808356ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.901659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.244338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T12:19:20.90168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.535348Z","time spent":"366.253001ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25776 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-04T12:19:20.901724Z","caller":"traceutil/trace.go:171","msg":"trace[1600373717] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25802; }","duration":"361.327429ms","start":"2026-05-04T12:19:20.540379Z","end":"2026-05-04T12:19:20.901706Z","steps":["trace[1600373717] 'agreement among raft nodes before linearized reading'  (duration: 361.144006ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:20.901754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.537631Z","time spent":"364.022799ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25778 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:20.901795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:20.540373Z","time spent":"361.408931ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"info","ts":"2026-05-04T12:19:38.301235Z","caller":"traceutil/trace.go:171","msg":"trace[1819329317] transaction","detail":"{read_only:false; response_revision:25939; number_of_response:1; }","duration":"154.612532ms","start":"2026-05-04T12:19:38.146597Z","end":"2026-05-04T12:19:38.30121Z","steps":["trace[1819329317] 'process raft request'  (duration: 154.347307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:38.556169Z","caller":"traceutil/trace.go:171","msg":"trace[994982166] transaction","detail":"{read_only:false; response_revision:25942; number_of_response:1; }","duration":"263.294524ms","start":"2026-05-04T12:19:38.292846Z","end":"2026-05-04T12:19:38.55614Z","steps":["trace[994982166] 'process raft request'  (duration: 263.237713ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:38.556599Z","caller":"traceutil/trace.go:171","msg":"trace[49163834] transaction","detail":"{read_only:false; response_revision:25940; number_of_response:1; }","duration":"272.464298ms","start":"2026-05-04T12:19:38.284123Z","end":"2026-05-04T12:19:38.556588Z","steps":["trace[49163834] 'process raft request'  (duration: 271.713863ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:38.556722Z","caller":"traceutil/trace.go:171","msg":"trace[1884045375] transaction","detail":"{read_only:false; response_revision:25941; number_of_response:1; }","duration":"267.716409ms","start":"2026-05-04T12:19:38.288997Z","end":"2026-05-04T12:19:38.556714Z","steps":["trace[1884045375] 'process raft request'  (duration: 267.026715ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:38.736809Z","caller":"traceutil/trace.go:171","msg":"trace[1171366931] transaction","detail":"{read_only:false; response_revision:25943; number_of_response:1; }","duration":"122.44075ms","start":"2026-05-04T12:19:38.614337Z","end":"2026-05-04T12:19:38.736778Z","steps":["trace[1171366931] 'process raft request'  (duration: 99.43338ms)","trace[1171366931] 'compare'  (duration: 22.834036ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:39.267684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.158609ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507649974 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25863 > 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:18"}
{"level":"info","ts":"2026-05-04T12:19:39.267904Z","caller":"traceutil/trace.go:171","msg":"trace[657253880] linearizableReadLoop","detail":"{readStateIndex:26795; appliedIndex:26794; }","duration":"245.591314ms","start":"2026-05-04T12:19:39.022295Z","end":"2026-05-04T12:19:39.267887Z","steps":["trace[657253880] 'read index received'  (duration: 111.15559ms)","trace[657253880] 'applied index is now lower than readState.Index'  (duration: 134.434134ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:39.267934Z","caller":"traceutil/trace.go:171","msg":"trace[2085161991] transaction","detail":"{read_only:false; response_revision:25945; number_of_response:1; }","duration":"275.496414ms","start":"2026-05-04T12:19:38.992402Z","end":"2026-05-04T12:19:39.267898Z","steps":["trace[2085161991] 'process raft request'  (duration: 141.027128ms)","trace[2085161991] 'compare'  (duration: 133.693991ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:19:39.268067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.918459ms","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":"warn","ts":"2026-05-04T12:19:39.268187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.208463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-04T12:19:39.268246Z","caller":"traceutil/trace.go:171","msg":"trace[1245335526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25945; }","duration":"279.341696ms","start":"2026-05-04T12:19:38.988894Z","end":"2026-05-04T12:19:39.268235Z","steps":["trace[1245335526] 'agreement among raft nodes before linearized reading'  (duration: 279.111332ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:39.268068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.616403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-04T12:19:39.268454Z","caller":"traceutil/trace.go:171","msg":"trace[1359830020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25945; }","duration":"262.038061ms","start":"2026-05-04T12:19:39.006402Z","end":"2026-05-04T12:19:39.26844Z","steps":["trace[1359830020] 'agreement among raft nodes before linearized reading'  (duration: 261.544722ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.269013Z","caller":"traceutil/trace.go:171","msg":"trace[472494249] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25945; }","duration":"262.910447ms","start":"2026-05-04T12:19:39.00608Z","end":"2026-05-04T12:19:39.268991Z","steps":["trace[472494249] 'agreement among raft nodes before linearized reading'  (duration: 261.868929ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.313775Z","caller":"traceutil/trace.go:171","msg":"trace[968415564] transaction","detail":"{read_only:false; response_revision:25947; number_of_response:1; }","duration":"203.530916ms","start":"2026-05-04T12:19:39.110216Z","end":"2026-05-04T12:19:39.313747Z","steps":["trace[968415564] 'process raft request'  (duration: 203.458415ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.313806Z","caller":"traceutil/trace.go:171","msg":"trace[1036758171] transaction","detail":"{read_only:false; response_revision:25946; number_of_response:1; }","duration":"285.45877ms","start":"2026-05-04T12:19:39.028312Z","end":"2026-05-04T12:19:39.313771Z","steps":["trace[1036758171] 'process raft request'  (duration: 285.198185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.487334Z","caller":"traceutil/trace.go:171","msg":"trace[414103116] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"268.484802ms","start":"2026-05-04T12:19:39.218822Z","end":"2026-05-04T12:19:39.487307Z","steps":["trace[414103116] 'process raft request'  (duration: 268.363269ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.487373Z","caller":"traceutil/trace.go:171","msg":"trace[23353792] transaction","detail":"{read_only:false; response_revision:25948; number_of_response:1; }","duration":"268.689076ms","start":"2026-05-04T12:19:39.218647Z","end":"2026-05-04T12:19:39.487336Z","steps":["trace[23353792] 'process raft request'  (duration: 268.33244ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.487664Z","caller":"traceutil/trace.go:171","msg":"trace[1374076568] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"214.733708ms","start":"2026-05-04T12:19:39.272906Z","end":"2026-05-04T12:19:39.48764Z","steps":["trace[1374076568] 'process raft request'  (duration: 214.35306ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.488185Z","caller":"traceutil/trace.go:171","msg":"trace[1222000340] linearizableReadLoop","detail":"{readStateIndex:26799; appliedIndex:26795; }","duration":"220.066167ms","start":"2026-05-04T12:19:39.268102Z","end":"2026-05-04T12:19:39.488169Z","steps":["trace[1222000340] 'read index received'  (duration: 45.46848ms)","trace[1222000340] 'applied index is now lower than readState.Index'  (duration: 174.596817ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:39.488358Z","caller":"traceutil/trace.go:171","msg":"trace[1328422315] transaction","detail":"{read_only:false; response_revision:25952; number_of_response:1; }","duration":"214.424261ms","start":"2026-05-04T12:19:39.273922Z","end":"2026-05-04T12:19:39.488347Z","steps":["trace[1328422315] 'process raft request'  (duration: 214.198207ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.488396Z","caller":"traceutil/trace.go:171","msg":"trace[684499226] transaction","detail":"{read_only:false; response_revision:25951; number_of_response:1; }","duration":"214.493172ms","start":"2026-05-04T12:19:39.273851Z","end":"2026-05-04T12:19:39.488345Z","steps":["trace[684499226] 'process raft request'  (duration: 213.667616ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:39.488566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.465764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-04T12:19:39.488602Z","caller":"traceutil/trace.go:171","msg":"trace[567994503] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:25952; }","duration":"406.584216ms","start":"2026-05-04T12:19:39.082007Z","end":"2026-05-04T12:19:39.488592Z","steps":["trace[567994503] 'agreement among raft nodes before linearized reading'  (duration: 406.227209ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:39.488632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:39.081972Z","time spent":"406.651687ms","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.227\" "}
{"level":"info","ts":"2026-05-04T12:19:39.859984Z","caller":"traceutil/trace.go:171","msg":"trace[1397766602] transaction","detail":"{read_only:false; response_revision:25953; number_of_response:1; }","duration":"534.726192ms","start":"2026-05-04T12:19:39.325237Z","end":"2026-05-04T12:19:39.859963Z","steps":["trace[1397766602] 'process raft request'  (duration: 534.58851ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:39.860131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:39.325204Z","time spent":"534.837264ms","remote":"127.0.0.1:55032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3290,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" mod_revision:25935 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" value_size:3217 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:39.878168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:39.489715Z","time spent":"388.437126ms","remote":"127.0.0.1:37010","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-05-04T12:19:39.878219Z","caller":"traceutil/trace.go:171","msg":"trace[485130760] transaction","detail":"{read_only:false; response_revision:25954; number_of_response:1; }","duration":"207.908939ms","start":"2026-05-04T12:19:39.670286Z","end":"2026-05-04T12:19:39.878195Z","steps":["trace[485130760] 'process raft request'  (duration: 207.754197ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:39.878411Z","caller":"traceutil/trace.go:171","msg":"trace[1403710977] linearizableReadLoop","detail":"{readStateIndex:26804; appliedIndex:26802; }","duration":"357.651811ms","start":"2026-05-04T12:19:39.520704Z","end":"2026-05-04T12:19:39.878356Z","steps":["trace[1403710977] 'read index received'  (duration: 339.057163ms)","trace[1403710977] 'applied index is now lower than readState.Index'  (duration: 18.592738ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:39.878471Z","caller":"traceutil/trace.go:171","msg":"trace[1971194613] transaction","detail":"{read_only:false; response_revision:25955; number_of_response:1; }","duration":"126.547088ms","start":"2026-05-04T12:19:39.75191Z","end":"2026-05-04T12:19:39.878457Z","steps":["trace[1971194613] 'process raft request'  (duration: 126.245212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:39.87857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.837394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:19:39.878617Z","caller":"traceutil/trace.go:171","msg":"trace[379658535] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:25955; }","duration":"357.935586ms","start":"2026-05-04T12:19:39.520667Z","end":"2026-05-04T12:19:39.878602Z","steps":["trace[379658535] 'agreement among raft nodes before linearized reading'  (duration: 357.832214ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:39.878659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:39.520644Z","time spent":"358.004388ms","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T12:19:40.170196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.968706ms","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-04T12:19:40.17031Z","caller":"traceutil/trace.go:171","msg":"trace[320938649] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:25956; }","duration":"250.112669ms","start":"2026-05-04T12:19:39.920175Z","end":"2026-05-04T12:19:40.170287Z","steps":["trace[320938649] 'range keys from in-memory index tree'  (duration: 249.762003ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:40.866723Z","caller":"traceutil/trace.go:171","msg":"trace[1767618456] transaction","detail":"{read_only:false; response_revision:25960; number_of_response:1; }","duration":"303.416576ms","start":"2026-05-04T12:19:40.563284Z","end":"2026-05-04T12:19:40.8667Z","steps":["trace[1767618456] 'process raft request'  (duration: 303.319624ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:40.866765Z","caller":"traceutil/trace.go:171","msg":"trace[1423900052] transaction","detail":"{read_only:false; response_revision:25959; number_of_response:1; }","duration":"303.475486ms","start":"2026-05-04T12:19:40.563238Z","end":"2026-05-04T12:19:40.866714Z","steps":["trace[1423900052] 'process raft request'  (duration: 303.196551ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:40.866919Z","caller":"traceutil/trace.go:171","msg":"trace[382419833] linearizableReadLoop","detail":"{readStateIndex:26812; appliedIndex:26809; }","duration":"199.951491ms","start":"2026-05-04T12:19:40.666912Z","end":"2026-05-04T12:19:40.866864Z","steps":["trace[382419833] 'read index received'  (duration: 199.534702ms)","trace[382419833] 'applied index is now lower than readState.Index'  (duration: 413.759µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:40.866974Z","caller":"traceutil/trace.go:171","msg":"trace[1033922149] transaction","detail":"{read_only:false; response_revision:25961; number_of_response:1; }","duration":"302.931097ms","start":"2026-05-04T12:19:40.563957Z","end":"2026-05-04T12:19:40.866888Z","steps":["trace[1033922149] 'process raft request'  (duration: 302.694792ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:40.867019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:40.563213Z","time spent":"303.655911ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25941 > 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-04T12:19:40.867107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:40.563257Z","time spent":"303.531908ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25915 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-04T12:19:40.867085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.128794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-04T12:19:40.867124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:19:40.563949Z","time spent":"303.116651ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25942 > 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-04T12:19:40.867183Z","caller":"traceutil/trace.go:171","msg":"trace[1047887632] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25961; }","duration":"200.306887ms","start":"2026-05-04T12:19:40.666852Z","end":"2026-05-04T12:19:40.867159Z","steps":["trace[1047887632] 'agreement among raft nodes before linearized reading'  (duration: 200.127284ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:40.871132Z","caller":"traceutil/trace.go:171","msg":"trace[1589350400] transaction","detail":"{read_only:false; response_revision:25962; number_of_response:1; }","duration":"128.536595ms","start":"2026-05-04T12:19:40.742584Z","end":"2026-05-04T12:19:40.871121Z","steps":["trace[1589350400] 'process raft request'  (duration: 128.482534ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:41.687587Z","caller":"traceutil/trace.go:171","msg":"trace[326791124] transaction","detail":"{read_only:false; response_revision:25970; number_of_response:1; }","duration":"151.544155ms","start":"2026-05-04T12:19:41.536016Z","end":"2026-05-04T12:19:41.68756Z","steps":["trace[326791124] 'process raft request'  (duration: 151.505224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:41.687927Z","caller":"traceutil/trace.go:171","msg":"trace[1176443163] linearizableReadLoop","detail":"{readStateIndex:26820; appliedIndex:26817; }","duration":"156.506798ms","start":"2026-05-04T12:19:41.531388Z","end":"2026-05-04T12:19:41.687895Z","steps":["trace[1176443163] 'read index received'  (duration: 70.811445ms)","trace[1176443163] 'applied index is now lower than readState.Index'  (duration: 85.692933ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:41.688023Z","caller":"traceutil/trace.go:171","msg":"trace[1321569183] transaction","detail":"{read_only:false; response_revision:25968; number_of_response:1; }","duration":"193.295156ms","start":"2026-05-04T12:19:41.494712Z","end":"2026-05-04T12:19:41.688007Z","steps":["trace[1321569183] 'process raft request'  (duration: 192.648455ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:41.688086Z","caller":"traceutil/trace.go:171","msg":"trace[780214129] transaction","detail":"{read_only:false; response_revision:25967; number_of_response:1; }","duration":"194.220384ms","start":"2026-05-04T12:19:41.493828Z","end":"2026-05-04T12:19:41.688048Z","steps":["trace[780214129] 'process raft request'  (duration: 108.395929ms)","trace[780214129] 'compare'  (duration: 84.748255ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:41.688091Z","caller":"traceutil/trace.go:171","msg":"trace[657906440] transaction","detail":"{read_only:false; response_revision:25969; number_of_response:1; }","duration":"192.106204ms","start":"2026-05-04T12:19:41.495928Z","end":"2026-05-04T12:19:41.688034Z","steps":["trace[657906440] 'process raft request'  (duration: 191.540213ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:41.688309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.270626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3308"}
{"level":"info","ts":"2026-05-04T12:19:41.688378Z","caller":"traceutil/trace.go:171","msg":"trace[170688858] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25970; }","duration":"193.401018ms","start":"2026-05-04T12:19:41.49496Z","end":"2026-05-04T12:19:41.688361Z","steps":["trace[170688858] 'agreement among raft nodes before linearized reading'  (duration: 193.087712ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:19:41.912614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.2034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:19:41.912692Z","caller":"traceutil/trace.go:171","msg":"trace[408528442] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:25970; }","duration":"111.303272ms","start":"2026-05-04T12:19:41.80137Z","end":"2026-05-04T12:19:41.912674Z","steps":["trace[408528442] 'count revisions from in-memory index tree'  (duration: 111.061337ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:44.090603Z","caller":"traceutil/trace.go:171","msg":"trace[1812315493] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"142.672408ms","start":"2026-05-04T12:19:43.947893Z","end":"2026-05-04T12:19:44.090565Z","steps":["trace[1812315493] 'process raft request'  (duration: 142.462285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:46.21218Z","caller":"traceutil/trace.go:171","msg":"trace[656737737] transaction","detail":"{read_only:false; response_revision:26000; number_of_response:1; }","duration":"115.609412ms","start":"2026-05-04T12:19:46.096517Z","end":"2026-05-04T12:19:46.212127Z","steps":["trace[656737737] 'process raft request'  (duration: 115.311897ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:19:58.006445Z","caller":"traceutil/trace.go:171","msg":"trace[255983941] transaction","detail":"{read_only:false; response_revision:26084; number_of_response:1; }","duration":"168.262968ms","start":"2026-05-04T12:19:57.838132Z","end":"2026-05-04T12:19:58.006395Z","steps":["trace[255983941] 'process raft request'  (duration: 96.221219ms)","trace[255983941] 'compare'  (duration: 71.414316ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:19:58.006574Z","caller":"traceutil/trace.go:171","msg":"trace[2097703009] transaction","detail":"{read_only:false; response_revision:26085; number_of_response:1; }","duration":"168.336569ms","start":"2026-05-04T12:19:57.838198Z","end":"2026-05-04T12:19:58.006535Z","steps":["trace[2097703009] 'process raft request'  (duration: 167.773739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:03.706725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.749639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T12:20:03.706838Z","caller":"traceutil/trace.go:171","msg":"trace[57578838] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:26151; }","duration":"119.944753ms","start":"2026-05-04T12:20:03.586868Z","end":"2026-05-04T12:20:03.706812Z","steps":["trace[57578838] 'count revisions from in-memory index tree'  (duration: 119.552266ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:03.759167Z","caller":"traceutil/trace.go:171","msg":"trace[848505910] transaction","detail":"{read_only:false; response_revision:26152; number_of_response:1; }","duration":"104.929562ms","start":"2026-05-04T12:20:03.654211Z","end":"2026-05-04T12:20:03.759141Z","steps":["trace[848505910] 'process raft request'  (duration: 104.764549ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:04.100345Z","caller":"traceutil/trace.go:171","msg":"trace[865501877] transaction","detail":"{read_only:false; response_revision:26154; number_of_response:1; }","duration":"133.019068ms","start":"2026-05-04T12:20:03.967282Z","end":"2026-05-04T12:20:04.100301Z","steps":["trace[865501877] 'process raft request'  (duration: 132.692902ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:04.318918Z","caller":"traceutil/trace.go:171","msg":"trace[1513866243] transaction","detail":"{read_only:false; response_revision:26156; number_of_response:1; }","duration":"213.941121ms","start":"2026-05-04T12:20:04.104948Z","end":"2026-05-04T12:20:04.318889Z","steps":["trace[1513866243] 'process raft request'  (duration: 213.777118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:04.319014Z","caller":"traceutil/trace.go:171","msg":"trace[997612018] linearizableReadLoop","detail":"{readStateIndex:27011; appliedIndex:27009; }","duration":"198.974263ms","start":"2026-05-04T12:20:04.120006Z","end":"2026-05-04T12:20:04.318981Z","steps":["trace[997612018] 'read index received'  (duration: 117.57124ms)","trace[997612018] 'applied index is now lower than readState.Index'  (duration: 81.401653ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:20:04.319157Z","caller":"traceutil/trace.go:171","msg":"trace[1448673508] transaction","detail":"{read_only:false; response_revision:26155; number_of_response:1; }","duration":"214.164956ms","start":"2026-05-04T12:20:04.104949Z","end":"2026-05-04T12:20:04.319114Z","steps":["trace[1448673508] 'process raft request'  (duration: 132.508417ms)","trace[1448673508] 'compare'  (duration: 80.980816ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T12:20:04.319234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.200337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:20:04.319307Z","caller":"traceutil/trace.go:171","msg":"trace[1839166347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26157; }","duration":"199.33415ms","start":"2026-05-04T12:20:04.119952Z","end":"2026-05-04T12:20:04.319287Z","steps":["trace[1839166347] 'agreement among raft nodes before linearized reading'  (duration: 199.190677ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:04.319221Z","caller":"traceutil/trace.go:171","msg":"trace[325290404] transaction","detail":"{read_only:false; response_revision:26157; number_of_response:1; }","duration":"100.022282ms","start":"2026-05-04T12:20:04.219139Z","end":"2026-05-04T12:20:04.319161Z","steps":["trace[325290404] 'process raft request'  (duration: 99.705035ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:04.36755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.230707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:20:04.36763Z","caller":"traceutil/trace.go:171","msg":"trace[737981088] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:26158; }","duration":"214.37186ms","start":"2026-05-04T12:20:04.153236Z","end":"2026-05-04T12:20:04.367608Z","steps":["trace[737981088] 'agreement among raft nodes before linearized reading'  (duration: 214.209947ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:04.764199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.494692ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656052451507650473 > lease_revoke:<id:21c29df2bf6f3e75>","response":"size:29"}
{"level":"info","ts":"2026-05-04T12:20:04.764521Z","caller":"traceutil/trace.go:171","msg":"trace[1151241379] transaction","detail":"{read_only:false; response_revision:26159; number_of_response:1; }","duration":"153.97411ms","start":"2026-05-04T12:20:04.610528Z","end":"2026-05-04T12:20:04.764502Z","steps":["trace[1151241379] 'process raft request'  (duration: 153.786357ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:05.228853Z","caller":"traceutil/trace.go:171","msg":"trace[590381515] transaction","detail":"{read_only:false; response_revision:26161; number_of_response:1; }","duration":"229.290619ms","start":"2026-05-04T12:20:04.999532Z","end":"2026-05-04T12:20:05.228823Z","steps":["trace[590381515] 'process raft request'  (duration: 229.088385ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T12:20:05.499097Z","caller":"traceutil/trace.go:171","msg":"trace[1124897175] transaction","detail":"{read_only:false; response_revision:26162; number_of_response:1; }","duration":"493.318368ms","start":"2026-05-04T12:20:05.005714Z","end":"2026-05-04T12:20:05.499032Z","steps":["trace[1124897175] 'process raft request'  (duration: 484.116036ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:05.49932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:20:05.005687Z","time spent":"493.496871ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26147 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-04T12:20:05.499829Z","caller":"traceutil/trace.go:171","msg":"trace[185438010] linearizableReadLoop","detail":"{readStateIndex:27019; appliedIndex:27017; }","duration":"482.301533ms","start":"2026-05-04T12:20:05.017501Z","end":"2026-05-04T12:20:05.499803Z","steps":["trace[185438010] 'read index received'  (duration: 212.100359ms)","trace[185438010] 'applied index is now lower than readState.Index'  (duration: 270.200174ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T12:20:05.499937Z","caller":"traceutil/trace.go:171","msg":"trace[1499278298] transaction","detail":"{read_only:false; response_revision:26163; number_of_response:1; }","duration":"490.748361ms","start":"2026-05-04T12:20:05.009178Z","end":"2026-05-04T12:20:05.499926Z","steps":["trace[1499278298] 'process raft request'  (duration: 489.456227ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:05.500009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:20:05.009153Z","time spent":"490.813252ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26148 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T12:20:05.500146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.623159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:20:05.500189Z","caller":"traceutil/trace.go:171","msg":"trace[147811650] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:26163; }","duration":"482.732161ms","start":"2026-05-04T12:20:05.017446Z","end":"2026-05-04T12:20:05.500178Z","steps":["trace[147811650] 'agreement among raft nodes before linearized reading'  (duration: 482.644889ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:05.500224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:20:05.017419Z","time spent":"482.796091ms","remote":"127.0.0.1:41098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":140,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T12:20:05.500404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.839448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T12:20:05.50044Z","caller":"traceutil/trace.go:171","msg":"trace[999636336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26163; }","duration":"431.912239ms","start":"2026-05-04T12:20:05.06852Z","end":"2026-05-04T12:20:05.500432Z","steps":["trace[999636336] 'agreement among raft nodes before linearized reading'  (duration: 431.862048ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:05.500465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:20:05.068495Z","time spent":"431.96552ms","remote":"127.0.0.1:36950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T12:20:05.500793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.266236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-04T12:20:05.500879Z","caller":"traceutil/trace.go:171","msg":"trace[2016607558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26163; }","duration":"355.423309ms","start":"2026-05-04T12:20:05.145438Z","end":"2026-05-04T12:20:05.500861Z","steps":["trace[2016607558] 'agreement among raft nodes before linearized reading'  (duration: 355.217504ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T12:20:05.502672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T12:20:05.145411Z","time spent":"355.565631ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-04T12:20:20.833848Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a82.wal"}
{"level":"info","ts":"2026-05-04T12:23:45.898276Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25462}
{"level":"info","ts":"2026-05-04T12:23:46.05579Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25462,"took":"153.313239ms","hash":2411503701,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":35995648,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-04T12:23:46.05585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2411503701,"revision":25462,"compact-revision":22090}
{"level":"info","ts":"2026-05-04T12:25:09.717266Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"572db18442eba1c2","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T12:25:09.723216Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-04T12:25:09.723371Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-04T12:28:45.904745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28417}
{"level":"info","ts":"2026-05-04T12:28:46.038796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28417,"took":"129.694204ms","hash":1872620888,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31629312,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-04T12:28:46.038866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1872620888,"revision":28417,"compact-revision":25462}
{"level":"info","ts":"2026-05-04T12:33:45.91257Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30664}
{"level":"info","ts":"2026-05-04T12:33:46.043228Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30664,"took":"127.240099ms","hash":2519084198,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30273536,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-04T12:33:46.043324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2519084198,"revision":30664,"compact-revision":28417}
{"level":"info","ts":"2026-05-04T12:38:45.921274Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32920}
{"level":"info","ts":"2026-05-04T12:38:46.074408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32920,"took":"148.816319ms","hash":2143101264,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31277056,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-04T12:38:46.074486Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2143101264,"revision":32920,"compact-revision":30664}
{"level":"info","ts":"2026-05-04T12:43:45.928196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35216}
{"level":"info","ts":"2026-05-04T12:43:46.074253Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35216,"took":"137.778855ms","hash":2620224022,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30945280,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-04T12:43:46.074329Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2620224022,"revision":35216,"compact-revision":32920}
{"level":"info","ts":"2026-05-04T12:46:38.234314Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"572db18442eba1c2","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T12:46:38.239286Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-04T12:46:38.239546Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-04T12:48:45.934827Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37442}
{"level":"info","ts":"2026-05-04T12:48:46.047824Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37442,"took":"109.404098ms","hash":3034086744,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31367168,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-04T12:48:46.047886Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3034086744,"revision":37442,"compact-revision":35216}