{"level":"warn","ts":"2026-08-22T12:58:33.146506Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-22T12:58:33.146582Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.182: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.182:2380","--initial-cluster=instance=https://199.204.45.182:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.182:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.182: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-08-22T12:58:33.146643Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-22T12:58:33.14672Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.182:2380"]}
{"level":"info","ts":"2026-08-22T12:58:33.146742Z","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-08-22T12:58:33.147371Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"]}
{"level":"info","ts":"2026-08-22T12:58:33.14745Z","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.182:2380"],"listen-peer-urls":["https://199.204.45.182:2380"],"advertise-client-urls":["https://199.204.45.182:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.182: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-08-22T12:58:33.184352Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"36.712306ms"}
{"level":"info","ts":"2026-08-22T12:58:33.247375Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e44ae1545340c14b","cluster-id":"7284b69afd367451"}
{"level":"info","ts":"2026-08-22T12:58:33.247487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=()"}
{"level":"info","ts":"2026-08-22T12:58:33.247514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became follower at term 0"}
{"level":"info","ts":"2026-08-22T12:58:33.247533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e44ae1545340c14b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-22T12:58:33.24755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became follower at term 1"}
{"level":"info","ts":"2026-08-22T12:58:33.247588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=(16450208341214413131)"}
{"level":"warn","ts":"2026-08-22T12:58:33.265594Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-22T12:58:33.270222Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-22T12:58:33.271561Z","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-08-22T12:58:33.274548Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e44ae1545340c14b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-22T12:58:33.274754Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e44ae1545340c14b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-22T12:58:33.274909Z","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-08-22T12:58:33.274999Z","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-08-22T12:58:33.275014Z","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-08-22T12:58:33.283164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=(16450208341214413131)"}
{"level":"info","ts":"2026-08-22T12:58:33.283367Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7284b69afd367451","local-member-id":"e44ae1545340c14b","added-peer-id":"e44ae1545340c14b","added-peer-peer-urls":["https://199.204.45.182:2380"]}
{"level":"info","ts":"2026-08-22T12:58:33.285778Z","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-08-22T12:58:33.28583Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.182:2380"}
{"level":"info","ts":"2026-08-22T12:58:33.285877Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.182:2380"}
{"level":"info","ts":"2026-08-22T12:58:33.287578Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e44ae1545340c14b","initial-advertise-peer-urls":["https://199.204.45.182:2380"],"listen-peer-urls":["https://199.204.45.182:2380"],"advertise-client-urls":["https://199.204.45.182:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-22T12:58:33.287614Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-22T12:58:33.948983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b is starting a new election at term 1"}
{"level":"info","ts":"2026-08-22T12:58:33.949049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-22T12:58:33.949087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b received MsgPreVoteResp from e44ae1545340c14b at term 1"}
{"level":"info","ts":"2026-08-22T12:58:33.949108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became candidate at term 2"}
{"level":"info","ts":"2026-08-22T12:58:33.949125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b received MsgVoteResp from e44ae1545340c14b at term 2"}
{"level":"info","ts":"2026-08-22T12:58:33.949147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became leader at term 2"}
{"level":"info","ts":"2026-08-22T12:58:33.949165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e44ae1545340c14b elected leader e44ae1545340c14b at term 2"}
{"level":"info","ts":"2026-08-22T12:58:33.950512Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e44ae1545340c14b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.182:2379]}","request-path":"/0/members/e44ae1545340c14b/attributes","cluster-id":"7284b69afd367451","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-22T12:58:33.950556Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-22T12:58:33.950553Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-22T12:58:33.950588Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-22T12:58:33.951965Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7284b69afd367451","local-member-id":"e44ae1545340c14b","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-22T12:58:33.952074Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-22T12:58:33.95211Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-22T12:58:33.952771Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.182:2379"}
{"level":"info","ts":"2026-08-22T12:58:33.953066Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-22T12:58:33.9531Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-22T12:58:33.953779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-08-22T12:59:15.439398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.493869ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896072728 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-22T12:59:15.439668Z","caller":"traceutil/trace.go:171","msg":"trace[874216864] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"254.954539ms","start":"2026-08-22T12:59:15.184696Z","end":"2026-08-22T12:59:15.439651Z","steps":["trace[874216864] 'read index received'  (duration: 141.655554ms)","trace[874216864] 'applied index is now lower than readState.Index'  (duration: 113.297795ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T12:59:15.439728Z","caller":"traceutil/trace.go:171","msg":"trace[2046238895] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"277.908353ms","start":"2026-08-22T12:59:15.16175Z","end":"2026-08-22T12:59:15.439659Z","steps":["trace[2046238895] 'process raft request'  (duration: 164.638689ms)","trace[2046238895] 'compare'  (duration: 112.301686ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T12:59:15.439844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.147532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-22T12:59:15.439878Z","caller":"traceutil/trace.go:171","msg":"trace[621592117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"255.224644ms","start":"2026-08-22T12:59:15.184644Z","end":"2026-08-22T12:59:15.439869Z","steps":["trace[621592117] 'agreement among raft nodes before linearized reading'  (duration: 255.069081ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T12:59:15.938498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.702121ms","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-08-22T12:59:15.938588Z","caller":"traceutil/trace.go:171","msg":"trace[312592873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"241.850194ms","start":"2026-08-22T12:59:15.696714Z","end":"2026-08-22T12:59:15.938564Z","steps":["trace[312592873] 'range keys from in-memory index tree'  (duration: 241.523847ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T12:59:15.9385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.785002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-22T12:59:15.938599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.417773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-22T12:59:15.938698Z","caller":"traceutil/trace.go:171","msg":"trace[744654927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"246.499395ms","start":"2026-08-22T12:59:15.692142Z","end":"2026-08-22T12:59:15.938641Z","steps":["trace[744654927] 'range keys from in-memory index tree'  (duration: 246.323201ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T12:59:15.938693Z","caller":"traceutil/trace.go:171","msg":"trace[1781984152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"339.020567ms","start":"2026-08-22T12:59:15.599614Z","end":"2026-08-22T12:59:15.938635Z","steps":["trace[1781984152] 'range keys from in-memory index tree'  (duration: 338.66669ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T12:59:15.938737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.703861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mf6dv\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-08-22T12:59:15.938814Z","caller":"traceutil/trace.go:171","msg":"trace[521936312] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mf6dv; range_end:; response_count:1; response_revision:587; }","duration":"337.816683ms","start":"2026-08-22T12:59:15.600976Z","end":"2026-08-22T12:59:15.938792Z","steps":["trace[521936312] 'range keys from in-memory index tree'  (duration: 337.526298ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T12:59:15.938782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T12:59:15.599582Z","time spent":"339.17304ms","remote":"127.0.0.1:45124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-22T12:59:15.938844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T12:59:15.600966Z","time spent":"337.872214ms","remote":"127.0.0.1:45312","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-mf6dv\" "}
{"level":"info","ts":"2026-08-22T13:00:54.782198Z","caller":"traceutil/trace.go:171","msg":"trace[1635788577] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"270.144037ms","start":"2026-08-22T13:00:54.512014Z","end":"2026-08-22T13:00:54.782158Z","steps":["trace[1635788577] 'process raft request'  (duration: 269.842631ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:00:54.792475Z","caller":"traceutil/trace.go:171","msg":"trace[1024935639] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1917; }","duration":"193.179028ms","start":"2026-08-22T13:00:54.599262Z","end":"2026-08-22T13:00:54.792441Z","steps":["trace[1024935639] 'read index received'  (duration: 182.554932ms)","trace[1024935639] 'applied index is now lower than readState.Index'  (duration: 10.622886ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:00:54.792683Z","caller":"traceutil/trace.go:171","msg":"trace[1994142525] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"256.406201ms","start":"2026-08-22T13:00:54.536262Z","end":"2026-08-22T13:00:54.792668Z","steps":["trace[1994142525] 'process raft request'  (duration: 256.015204ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:00:54.79279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.496014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-22T13:00:54.792881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.133222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-22T13:00:54.792948Z","caller":"traceutil/trace.go:171","msg":"trace[322711716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1852; }","duration":"109.258264ms","start":"2026-08-22T13:00:54.683663Z","end":"2026-08-22T13:00:54.792921Z","steps":["trace[322711716] 'agreement among raft nodes before linearized reading'  (duration: 108.978839ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:00:54.792972Z","caller":"traceutil/trace.go:171","msg":"trace[1744858610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"193.702157ms","start":"2026-08-22T13:00:54.599186Z","end":"2026-08-22T13:00:54.792889Z","steps":["trace[1744858610] 'agreement among raft nodes before linearized reading'  (duration: 193.462403ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:00:55.303476Z","caller":"traceutil/trace.go:171","msg":"trace[1784246034] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1921; }","duration":"156.035659ms","start":"2026-08-22T13:00:55.14587Z","end":"2026-08-22T13:00:55.301906Z","steps":["trace[1784246034] 'read index received'  (duration: 81.913224ms)","trace[1784246034] 'applied index is now lower than readState.Index'  (duration: 74.120835ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:00:55.303944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.059048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba54a249-b510-44be-b163-f313228ff229\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-22T13:00:55.303938Z","caller":"traceutil/trace.go:171","msg":"trace[860369845] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"213.856368ms","start":"2026-08-22T13:00:55.090042Z","end":"2026-08-22T13:00:55.303898Z","steps":["trace[860369845] 'process raft request'  (duration: 137.814816ms)","trace[860369845] 'compare'  (duration: 72.082796ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:00:55.30406Z","caller":"traceutil/trace.go:171","msg":"trace[909152505] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba54a249-b510-44be-b163-f313228ff229; range_end:; response_count:1; response_revision:1855; }","duration":"158.18329ms","start":"2026-08-22T13:00:55.145853Z","end":"2026-08-22T13:00:55.304036Z","steps":["trace[909152505] 'agreement among raft nodes before linearized reading'  (duration: 157.540528ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:01:46.621828Z","caller":"traceutil/trace.go:171","msg":"trace[110102504] linearizableReadLoop","detail":"{readStateIndex:2261; appliedIndex:2260; }","duration":"237.548395ms","start":"2026-08-22T13:01:46.384254Z","end":"2026-08-22T13:01:46.621802Z","steps":["trace[110102504] 'read index received'  (duration: 150.58605ms)","trace[110102504] 'applied index is now lower than readState.Index'  (duration: 86.961125ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:01:46.621889Z","caller":"traceutil/trace.go:171","msg":"trace[236069584] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"303.459694ms","start":"2026-08-22T13:01:46.318389Z","end":"2026-08-22T13:01:46.621849Z","steps":["trace[236069584] 'process raft request'  (duration: 216.454108ms)","trace[236069584] 'compare'  (duration: 86.842083ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:01:46.622282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:01:46.318354Z","time spent":"303.607646ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2173 > 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-08-22T13:01:46.62232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.698788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:01:46.622505Z","caller":"traceutil/trace.go:171","msg":"trace[1673837042] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2183; }","duration":"238.27961ms","start":"2026-08-22T13:01:46.384211Z","end":"2026-08-22T13:01:46.622491Z","steps":["trace[1673837042] 'agreement among raft nodes before linearized reading'  (duration: 237.703578ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:02:43.926051Z","caller":"traceutil/trace.go:171","msg":"trace[98298316] linearizableReadLoop","detail":"{readStateIndex:2760; appliedIndex:2759; }","duration":"182.06631ms","start":"2026-08-22T13:02:43.743959Z","end":"2026-08-22T13:02:43.926025Z","steps":["trace[98298316] 'read index received'  (duration: 181.944618ms)","trace[98298316] 'applied index is now lower than readState.Index'  (duration: 120.612µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:02:43.926157Z","caller":"traceutil/trace.go:171","msg":"trace[197111000] transaction","detail":"{read_only:false; response_revision:2663; number_of_response:1; }","duration":"191.836748ms","start":"2026-08-22T13:02:43.734291Z","end":"2026-08-22T13:02:43.926128Z","steps":["trace[197111000] 'process raft request'  (duration: 191.575283ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:02:43.926186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.207422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:02:43.926254Z","caller":"traceutil/trace.go:171","msg":"trace[1105620747] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2663; }","duration":"182.337035ms","start":"2026-08-22T13:02:43.743901Z","end":"2026-08-22T13:02:43.926238Z","steps":["trace[1105620747] 'agreement among raft nodes before linearized reading'  (duration: 182.225153ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:02:43.927062Z","caller":"traceutil/trace.go:171","msg":"trace[1968754230] transaction","detail":"{read_only:false; response_revision:2664; number_of_response:1; }","duration":"161.471254ms","start":"2026-08-22T13:02:43.765567Z","end":"2026-08-22T13:02:43.927038Z","steps":["trace[1968754230] 'process raft request'  (duration: 161.328711ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:03:14.274923Z","caller":"traceutil/trace.go:171","msg":"trace[1512471276] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"137.023445ms","start":"2026-08-22T13:03:14.137874Z","end":"2026-08-22T13:03:14.274898Z","steps":["trace[1512471276] 'process raft request'  (duration: 136.839251ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:14.315061Z","caller":"traceutil/trace.go:171","msg":"trace[2125572908] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"105.923466ms","start":"2026-08-22T13:07:14.209096Z","end":"2026-08-22T13:07:14.31502Z","steps":["trace[2125572908] 'process raft request'  (duration: 104.938077ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:19.904751Z","caller":"traceutil/trace.go:171","msg":"trace[640028686] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"151.468263ms","start":"2026-08-22T13:07:19.753258Z","end":"2026-08-22T13:07:19.904726Z","steps":["trace[640028686] 'process raft request'  (duration: 151.28708ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:19.915461Z","caller":"traceutil/trace.go:171","msg":"trace[513355209] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5133; }","duration":"102.036473ms","start":"2026-08-22T13:07:19.813401Z","end":"2026-08-22T13:07:19.915437Z","steps":["trace[513355209] 'read index received'  (duration: 91.135558ms)","trace[513355209] 'applied index is now lower than readState.Index'  (duration: 10.899845ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:07:19.915662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.244827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-08-22T13:07:19.915699Z","caller":"traceutil/trace.go:171","msg":"trace[305962560] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4951; }","duration":"102.335599ms","start":"2026-08-22T13:07:19.81335Z","end":"2026-08-22T13:07:19.915686Z","steps":["trace[305962560] 'agreement among raft nodes before linearized reading'  (duration: 102.170496ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:19.91588Z","caller":"traceutil/trace.go:171","msg":"trace[639416714] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"160.524604ms","start":"2026-08-22T13:07:19.755331Z","end":"2026-08-22T13:07:19.915855Z","steps":["trace[639416714] 'process raft request'  (duration: 160.004744ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:23.804018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.146526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"}
{"level":"info","ts":"2026-08-22T13:07:23.804137Z","caller":"traceutil/trace.go:171","msg":"trace[460420189] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5104; }","duration":"135.322709ms","start":"2026-08-22T13:07:23.668798Z","end":"2026-08-22T13:07:23.804121Z","steps":["trace[460420189] 'range keys from in-memory index tree'  (duration: 134.981202ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:23.804281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.968557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786908"}
{"level":"info","ts":"2026-08-22T13:07:23.804359Z","caller":"traceutil/trace.go:171","msg":"trace[1541813637] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5104; }","duration":"105.058289ms","start":"2026-08-22T13:07:23.699284Z","end":"2026-08-22T13:07:23.804343Z","steps":["trace[1541813637] 'range keys from in-memory index tree'  (duration: 104.503579ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:36.744407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.272439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:07:36.744514Z","caller":"traceutil/trace.go:171","msg":"trace[828890642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5366; }","duration":"143.440362ms","start":"2026-08-22T13:07:36.601053Z","end":"2026-08-22T13:07:36.744494Z","steps":["trace[828890642] 'range keys from in-memory index tree'  (duration: 143.179478ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:36.744839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.889063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4c969e59-d443-4bfe-9044-0d36de19eff4\" ","response":"range_response_count:1 size:1293"}
{"level":"info","ts":"2026-08-22T13:07:36.74495Z","caller":"traceutil/trace.go:171","msg":"trace[1890496511] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4c969e59-d443-4bfe-9044-0d36de19eff4; range_end:; response_count:1; response_revision:5366; }","duration":"142.035695ms","start":"2026-08-22T13:07:36.602891Z","end":"2026-08-22T13:07:36.744927Z","steps":["trace[1890496511] 'range keys from in-memory index tree'  (duration: 141.689589ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:37.340396Z","caller":"traceutil/trace.go:171","msg":"trace[475838753] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"195.492264ms","start":"2026-08-22T13:07:37.144877Z","end":"2026-08-22T13:07:37.34037Z","steps":["trace[475838753] 'process raft request'  (duration: 195.333831ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:37.414032Z","caller":"traceutil/trace.go:171","msg":"trace[406912642] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"101.658855ms","start":"2026-08-22T13:07:37.31234Z","end":"2026-08-22T13:07:37.413999Z","steps":["trace[406912642] 'process raft request'  (duration: 99.030735ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:07:44.408191Z","caller":"traceutil/trace.go:171","msg":"trace[198469462] linearizableReadLoop","detail":"{readStateIndex:5743; appliedIndex:5742; }","duration":"175.216662ms","start":"2026-08-22T13:07:44.232956Z","end":"2026-08-22T13:07:44.408172Z","steps":["trace[198469462] 'read index received'  (duration: 175.080829ms)","trace[198469462] 'applied index is now lower than readState.Index'  (duration: 135.233µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:07:44.408271Z","caller":"traceutil/trace.go:171","msg":"trace[31196026] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"283.322998ms","start":"2026-08-22T13:07:44.124924Z","end":"2026-08-22T13:07:44.408247Z","steps":["trace[31196026] 'process raft request'  (duration: 283.136955ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:44.408381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.410995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mmn46\" ","response":"range_response_count:1 size:6451"}
{"level":"info","ts":"2026-08-22T13:07:44.408412Z","caller":"traceutil/trace.go:171","msg":"trace[1962009317] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mmn46; range_end:; response_count:1; response_revision:5544; }","duration":"175.486696ms","start":"2026-08-22T13:07:44.232918Z","end":"2026-08-22T13:07:44.408404Z","steps":["trace[1962009317] 'agreement among raft nodes before linearized reading'  (duration: 175.360964ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:44.414294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.306179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:07:44.414428Z","caller":"traceutil/trace.go:171","msg":"trace[417459433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:5545; }","duration":"170.492032ms","start":"2026-08-22T13:07:44.24391Z","end":"2026-08-22T13:07:44.414402Z","steps":["trace[417459433] 'agreement among raft nodes before linearized reading'  (duration: 170.246237ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:07:44.414629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.9224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c68d2f42-0ec7-43b1-82d9-d0c03d65e24c\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-08-22T13:07:44.414812Z","caller":"traceutil/trace.go:171","msg":"trace[1881939775] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c68d2f42-0ec7-43b1-82d9-d0c03d65e24c; range_end:; response_count:1; response_revision:5545; }","duration":"137.157624ms","start":"2026-08-22T13:07:44.277625Z","end":"2026-08-22T13:07:44.414782Z","steps":["trace[1881939775] 'agreement among raft nodes before linearized reading'  (duration: 136.591913ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:08:33.980687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958}
{"level":"info","ts":"2026-08-22T13:08:34.050309Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"67.573724ms","hash":2477740710,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":33656832,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-22T13:08:34.050369Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2477740710,"revision":2958,"compact-revision":-1}
{"level":"info","ts":"2026-08-22T13:13:33.987267Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6004}
{"level":"info","ts":"2026-08-22T13:13:34.093611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6004,"took":"104.019492ms","hash":1697309381,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":21311488,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-08-22T13:13:34.093709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1697309381,"revision":6004,"compact-revision":2958}
{"level":"info","ts":"2026-08-22T13:13:58.837064Z","caller":"traceutil/trace.go:171","msg":"trace[814354760] transaction","detail":"{read_only:false; response_revision:8384; number_of_response:1; }","duration":"119.495406ms","start":"2026-08-22T13:13:58.717545Z","end":"2026-08-22T13:13:58.837041Z","steps":["trace[814354760] 'process raft request'  (duration: 119.334993ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:13:58.994542Z","caller":"traceutil/trace.go:171","msg":"trace[24780040] transaction","detail":"{read_only:false; response_revision:8385; number_of_response:1; }","duration":"173.599342ms","start":"2026-08-22T13:13:58.82092Z","end":"2026-08-22T13:13:58.99452Z","steps":["trace[24780040] 'process raft request'  (duration: 173.436609ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:13:58.995512Z","caller":"traceutil/trace.go:171","msg":"trace[321956936] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"174.374926ms","start":"2026-08-22T13:13:58.821102Z","end":"2026-08-22T13:13:58.995477Z","steps":["trace[321956936] 'process raft request'  (duration: 173.388477ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:14:10.933853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.266609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mmn46\" ","response":"range_response_count:1 size:6451"}
{"level":"info","ts":"2026-08-22T13:14:10.933949Z","caller":"traceutil/trace.go:171","msg":"trace[2074958920] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mmn46; range_end:; response_count:1; response_revision:8443; }","duration":"218.406702ms","start":"2026-08-22T13:14:10.715523Z","end":"2026-08-22T13:14:10.933929Z","steps":["trace[2074958920] 'range keys from in-memory index tree'  (duration: 218.077016ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:14:52.155942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.622446ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896092362 > lease_revoke:<id:414ba0298d2def54>","response":"size:28"}
{"level":"info","ts":"2026-08-22T13:14:52.156424Z","caller":"traceutil/trace.go:171","msg":"trace[1171076355] linearizableReadLoop","detail":"{readStateIndex:9074; appliedIndex:9073; }","duration":"203.58532ms","start":"2026-08-22T13:14:51.952802Z","end":"2026-08-22T13:14:52.156387Z","steps":["trace[1171076355] 'read index received'  (duration: 4.436075ms)","trace[1171076355] 'applied index is now lower than readState.Index'  (duration: 199.145905ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:14:52.156547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.739753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:14:52.156584Z","caller":"traceutil/trace.go:171","msg":"trace[2010416524] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:8764; }","duration":"203.787744ms","start":"2026-08-22T13:14:51.952784Z","end":"2026-08-22T13:14:52.156571Z","steps":["trace[2010416524] 'agreement among raft nodes before linearized reading'  (duration: 203.694382ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:14:52.364635Z","caller":"traceutil/trace.go:171","msg":"trace[1470714086] transaction","detail":"{read_only:false; response_revision:8767; number_of_response:1; }","duration":"194.060089ms","start":"2026-08-22T13:14:52.170555Z","end":"2026-08-22T13:14:52.364615Z","steps":["trace[1470714086] 'process raft request'  (duration: 175.118741ms)","trace[1470714086] 'compare'  (duration: 18.817246ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:14:52.364628Z","caller":"traceutil/trace.go:171","msg":"trace[1327775204] linearizableReadLoop","detail":"{readStateIndex:9077; appliedIndex:9075; }","duration":"194.042619ms","start":"2026-08-22T13:14:52.170557Z","end":"2026-08-22T13:14:52.3646Z","steps":["trace[1327775204] 'read index received'  (duration: 15.175928ms)","trace[1327775204] 'applied index is now lower than readState.Index'  (duration: 178.865501ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:14:52.364802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.226972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-58b5r\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-08-22T13:14:52.364841Z","caller":"traceutil/trace.go:171","msg":"trace[1572154096] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-58b5r; range_end:; response_count:1; response_revision:8767; }","duration":"194.323163ms","start":"2026-08-22T13:14:52.170508Z","end":"2026-08-22T13:14:52.364831Z","steps":["trace[1572154096] 'agreement among raft nodes before linearized reading'  (duration: 194.166831ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:14:53.207774Z","caller":"traceutil/trace.go:171","msg":"trace[257981812] transaction","detail":"{read_only:false; response_revision:8770; number_of_response:1; }","duration":"314.647216ms","start":"2026-08-22T13:14:52.893105Z","end":"2026-08-22T13:14:53.207752Z","steps":["trace[257981812] 'process raft request'  (duration: 314.466882ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:14:53.207901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:14:52.893068Z","time spent":"314.767627ms","remote":"127.0.0.1:58904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5857,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" mod_revision:8617 > success:<request_put:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" value_size:5799 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" > >"}
{"level":"info","ts":"2026-08-22T13:14:53.748238Z","caller":"traceutil/trace.go:171","msg":"trace[493477206] transaction","detail":"{read_only:false; response_revision:8779; number_of_response:1; }","duration":"102.747977ms","start":"2026-08-22T13:14:53.645453Z","end":"2026-08-22T13:14:53.748201Z","steps":["trace[493477206] 'process raft request'  (duration: 102.515393ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:15:14.966961Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002488.wal"}
{"level":"info","ts":"2026-08-22T13:15:49.729325Z","caller":"traceutil/trace.go:171","msg":"trace[345300530] transaction","detail":"{read_only:false; response_revision:9355; number_of_response:1; }","duration":"102.863886ms","start":"2026-08-22T13:15:49.626413Z","end":"2026-08-22T13:15:49.729277Z","steps":["trace[345300530] 'process raft request'  (duration: 33.607269ms)","trace[345300530] 'compare'  (duration: 69.090403ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:15:53.995744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.391766ms","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-08-22T13:15:53.995772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.920487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-mzx7s\" ","response":"range_response_count:1 size:19075"}
{"level":"info","ts":"2026-08-22T13:15:53.995852Z","caller":"traceutil/trace.go:171","msg":"trace[1769482494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9411; }","duration":"234.541468ms","start":"2026-08-22T13:15:53.761286Z","end":"2026-08-22T13:15:53.995828Z","steps":["trace[1769482494] 'range keys from in-memory index tree'  (duration: 234.160302ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:15:53.995884Z","caller":"traceutil/trace.go:171","msg":"trace[689014272] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-mzx7s; range_end:; response_count:1; response_revision:9411; }","duration":"244.08446ms","start":"2026-08-22T13:15:53.751774Z","end":"2026-08-22T13:15:53.995859Z","steps":["trace[689014272] 'range keys from in-memory index tree'  (duration: 243.704833ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:15:54.171902Z","caller":"traceutil/trace.go:171","msg":"trace[1106705478] transaction","detail":"{read_only:false; response_revision:9415; number_of_response:1; }","duration":"114.511137ms","start":"2026-08-22T13:15:54.057354Z","end":"2026-08-22T13:15:54.171865Z","steps":["trace[1106705478] 'process raft request'  (duration: 114.130339ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:16:27.102236Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-22T13:16:27.108669Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-22T13:16:27.108764Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-22T13:18:33.993393Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8073}
{"level":"info","ts":"2026-08-22T13:18:34.055804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8073,"took":"59.859174ms","hash":1302471202,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":29282304,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-22T13:18:34.055898Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1302471202,"revision":8073,"compact-revision":6004}
{"level":"warn","ts":"2026-08-22T13:19:26.434745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.225196ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896098676 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:11212 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-22T13:19:26.43489Z","caller":"traceutil/trace.go:171","msg":"trace[1561978192] linearizableReadLoop","detail":"{readStateIndex:11601; appliedIndex:11600; }","duration":"208.563138ms","start":"2026-08-22T13:19:26.226305Z","end":"2026-08-22T13:19:26.434868Z","steps":["trace[1561978192] 'read index received'  (duration: 51.026886ms)","trace[1561978192] 'applied index is now lower than readState.Index'  (duration: 157.534712ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:19:26.434968Z","caller":"traceutil/trace.go:171","msg":"trace[737330896] transaction","detail":"{read_only:false; response_revision:11224; number_of_response:1; }","duration":"217.5468ms","start":"2026-08-22T13:19:26.21741Z","end":"2026-08-22T13:19:26.434956Z","steps":["trace[737330896] 'process raft request'  (duration: 59.971647ms)","trace[737330896] 'compare'  (duration: 156.939811ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:19:26.435215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.876414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-22T13:19:26.435302Z","caller":"traceutil/trace.go:171","msg":"trace[1501864605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11224; }","duration":"209.031147ms","start":"2026-08-22T13:19:26.226249Z","end":"2026-08-22T13:19:26.435281Z","steps":["trace[1501864605] 'agreement among raft nodes before linearized reading'  (duration: 208.744412ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:19:26.445135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.413817ms","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-08-22T13:19:26.44531Z","caller":"traceutil/trace.go:171","msg":"trace[1495925779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11225; }","duration":"217.617712ms","start":"2026-08-22T13:19:26.227662Z","end":"2026-08-22T13:19:26.445279Z","steps":["trace[1495925779] 'agreement among raft nodes before linearized reading'  (duration: 217.239664ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:19:26.445728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.672871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-22T13:19:26.445831Z","caller":"traceutil/trace.go:171","msg":"trace[1406445393] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:11226; }","duration":"116.819744ms","start":"2026-08-22T13:19:26.328987Z","end":"2026-08-22T13:19:26.445807Z","steps":["trace[1406445393] 'agreement among raft nodes before linearized reading'  (duration: 116.631361ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:19:48.954294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.021796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-22T13:19:48.954383Z","caller":"traceutil/trace.go:171","msg":"trace[160170795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11351; }","duration":"187.207081ms","start":"2026-08-22T13:19:48.767158Z","end":"2026-08-22T13:19:48.954365Z","steps":["trace[160170795] 'range keys from in-memory index tree'  (duration: 186.823943ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:19:48.954428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.913149ms","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-08-22T13:19:48.954491Z","caller":"traceutil/trace.go:171","msg":"trace[1277163292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11351; }","duration":"117.042732ms","start":"2026-08-22T13:19:48.83743Z","end":"2026-08-22T13:19:48.954473Z","steps":["trace[1277163292] 'range keys from in-memory index tree'  (duration: 116.676596ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:23:34.000923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10646}
{"level":"info","ts":"2026-08-22T13:23:34.087933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10646,"took":"84.33038ms","hash":1475447379,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":28110848,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-22T13:23:34.088034Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1475447379,"revision":10646,"compact-revision":8073}
{"level":"info","ts":"2026-08-22T13:26:12.591217Z","caller":"traceutil/trace.go:171","msg":"trace[1072310453] transaction","detail":"{read_only:false; response_revision:13919; number_of_response:1; }","duration":"154.825051ms","start":"2026-08-22T13:26:12.436359Z","end":"2026-08-22T13:26:12.591184Z","steps":["trace[1072310453] 'process raft request'  (duration: 137.394118ms)","trace[1072310453] 'compare'  (duration: 17.222149ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:26:17.180746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.072141ms","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-08-22T13:26:17.180938Z","caller":"traceutil/trace.go:171","msg":"trace[1417888029] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:13943; }","duration":"119.285714ms","start":"2026-08-22T13:26:17.061623Z","end":"2026-08-22T13:26:17.180909Z","steps":["trace[1417888029] 'range keys from in-memory index tree'  (duration: 119.052999ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:17.18152Z","caller":"traceutil/trace.go:171","msg":"trace[51194310] transaction","detail":"{read_only:false; response_revision:13944; number_of_response:1; }","duration":"162.189641ms","start":"2026-08-22T13:26:17.019291Z","end":"2026-08-22T13:26:17.181481Z","steps":["trace[51194310] 'process raft request'  (duration: 155.188617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:17.189378Z","caller":"traceutil/trace.go:171","msg":"trace[1618992084] transaction","detail":"{read_only:false; response_revision:13945; number_of_response:1; }","duration":"169.650354ms","start":"2026-08-22T13:26:17.019678Z","end":"2026-08-22T13:26:17.189328Z","steps":["trace[1618992084] 'process raft request'  (duration: 169.43187ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:18.21059Z","caller":"traceutil/trace.go:171","msg":"trace[872922343] transaction","detail":"{read_only:false; response_revision:13948; number_of_response:1; }","duration":"203.698742ms","start":"2026-08-22T13:26:18.006862Z","end":"2026-08-22T13:26:18.210561Z","steps":["trace[872922343] 'process raft request'  (duration: 203.547929ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:18.324498Z","caller":"traceutil/trace.go:171","msg":"trace[759173731] linearizableReadLoop","detail":"{readStateIndex:14423; appliedIndex:14421; }","duration":"241.243888ms","start":"2026-08-22T13:26:18.083227Z","end":"2026-08-22T13:26:18.32447Z","steps":["trace[759173731] 'read index received'  (duration: 127.241684ms)","trace[759173731] 'applied index is now lower than readState.Index'  (duration: 114.000964ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:26:18.324644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.38922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-22T13:26:18.324627Z","caller":"traceutil/trace.go:171","msg":"trace[347539316] transaction","detail":"{read_only:false; response_revision:13949; number_of_response:1; }","duration":"315.453293ms","start":"2026-08-22T13:26:18.009127Z","end":"2026-08-22T13:26:18.32458Z","steps":["trace[347539316] 'process raft request'  (duration: 311.289913ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:18.324689Z","caller":"traceutil/trace.go:171","msg":"trace[1386649906] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:13949; }","duration":"241.505432ms","start":"2026-08-22T13:26:18.083168Z","end":"2026-08-22T13:26:18.324673Z","steps":["trace[1386649906] 'agreement among raft nodes before linearized reading'  (duration: 241.40379ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:26:18.324819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:26:18.009099Z","time spent":"315.619785ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:13939 > 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-08-22T13:26:23.334528Z","caller":"traceutil/trace.go:171","msg":"trace[2008068180] transaction","detail":"{read_only:false; response_revision:14004; number_of_response:1; }","duration":"104.856588ms","start":"2026-08-22T13:26:23.229638Z","end":"2026-08-22T13:26:23.334494Z","steps":["trace[2008068180] 'process raft request'  (duration: 79.989114ms)","trace[2008068180] 'compare'  (duration: 24.67995ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:26:43.328234Z","caller":"traceutil/trace.go:171","msg":"trace[1329968935] transaction","detail":"{read_only:false; response_revision:14288; number_of_response:1; }","duration":"106.286436ms","start":"2026-08-22T13:26:43.221904Z","end":"2026-08-22T13:26:43.32819Z","steps":["trace[1329968935] 'process raft request'  (duration: 106.088672ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:43.630042Z","caller":"traceutil/trace.go:171","msg":"trace[1001955072] transaction","detail":"{read_only:false; response_revision:14289; number_of_response:1; }","duration":"297.193224ms","start":"2026-08-22T13:26:43.332747Z","end":"2026-08-22T13:26:43.62994Z","steps":["trace[1001955072] 'process raft request'  (duration: 275.782556ms)","trace[1001955072] 'compare'  (duration: 20.654504ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:26:43.634635Z","caller":"traceutil/trace.go:171","msg":"trace[1761471800] linearizableReadLoop","detail":"{readStateIndex:14779; appliedIndex:14777; }","duration":"242.988161ms","start":"2026-08-22T13:26:43.391622Z","end":"2026-08-22T13:26:43.63461Z","steps":["trace[1761471800] 'read index received'  (duration: 216.972655ms)","trace[1761471800] 'applied index is now lower than readState.Index'  (duration: 26.014626ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:26:43.635033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.398999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-08-22T13:26:43.635035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.441692ms","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-08-22T13:26:43.635122Z","caller":"traceutil/trace.go:171","msg":"trace[910367472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14291; }","duration":"209.594285ms","start":"2026-08-22T13:26:43.425507Z","end":"2026-08-22T13:26:43.635101Z","steps":["trace[910367472] 'agreement among raft nodes before linearized reading'  (duration: 209.36438ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:43.635188Z","caller":"traceutil/trace.go:171","msg":"trace[1003632067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14291; }","duration":"243.555732ms","start":"2026-08-22T13:26:43.391549Z","end":"2026-08-22T13:26:43.635105Z","steps":["trace[1003632067] 'agreement among raft nodes before linearized reading'  (duration: 243.286377ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:26:43.635146Z","caller":"traceutil/trace.go:171","msg":"trace[964991042] transaction","detail":"{read_only:false; response_revision:14290; number_of_response:1; }","duration":"299.196213ms","start":"2026-08-22T13:26:43.335873Z","end":"2026-08-22T13:26:43.63507Z","steps":["trace[964991042] 'process raft request'  (duration: 298.580961ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:28:08.216952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.396921ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896110198 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:15081 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-22T13:28:08.217052Z","caller":"traceutil/trace.go:171","msg":"trace[823029950] linearizableReadLoop","detail":"{readStateIndex:15605; appliedIndex:15604; }","duration":"134.659766ms","start":"2026-08-22T13:28:08.082376Z","end":"2026-08-22T13:28:08.217036Z","steps":["trace[823029950] 'read index received'  (duration: 20.042471ms)","trace[823029950] 'applied index is now lower than readState.Index'  (duration: 114.615895ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:28:08.217121Z","caller":"traceutil/trace.go:171","msg":"trace[158514123] transaction","detail":"{read_only:false; response_revision:15092; number_of_response:1; }","duration":"140.236443ms","start":"2026-08-22T13:28:08.076876Z","end":"2026-08-22T13:28:08.217112Z","steps":["trace[158514123] 'process raft request'  (duration: 25.599958ms)","trace[158514123] 'compare'  (duration: 114.290008ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:28:08.21725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.87431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:28:08.217272Z","caller":"traceutil/trace.go:171","msg":"trace[2096105433] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15092; }","duration":"134.910561ms","start":"2026-08-22T13:28:08.082354Z","end":"2026-08-22T13:28:08.217265Z","steps":["trace[2096105433] 'agreement among raft nodes before linearized reading'  (duration: 134.868041ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:28:08.220629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.916508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:28:08.220723Z","caller":"traceutil/trace.go:171","msg":"trace[1353652063] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15093; }","duration":"138.057891ms","start":"2026-08-22T13:28:08.082645Z","end":"2026-08-22T13:28:08.220703Z","steps":["trace[1353652063] 'agreement among raft nodes before linearized reading'  (duration: 137.879487ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:28:08.220734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.00571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-22T13:28:08.220771Z","caller":"traceutil/trace.go:171","msg":"trace[345901829] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15093; }","duration":"138.044031ms","start":"2026-08-22T13:28:08.082717Z","end":"2026-08-22T13:28:08.220761Z","steps":["trace[345901829] 'agreement among raft nodes before linearized reading'  (duration: 137.97529ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:28:08.220775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.628414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-08-22T13:28:08.220866Z","caller":"traceutil/trace.go:171","msg":"trace[197026390] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15093; }","duration":"136.749605ms","start":"2026-08-22T13:28:08.084096Z","end":"2026-08-22T13:28:08.220845Z","steps":["trace[197026390] 'agreement among raft nodes before linearized reading'  (duration: 136.492561ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:28:08.531269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.943602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-22T13:28:08.531377Z","caller":"traceutil/trace.go:171","msg":"trace[2043208940] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15093; }","duration":"124.130496ms","start":"2026-08-22T13:28:08.407224Z","end":"2026-08-22T13:28:08.531354Z","steps":["trace[2043208940] 'count revisions from in-memory index tree'  (duration: 123.83567ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:28:08.877649Z","caller":"traceutil/trace.go:171","msg":"trace[234807427] transaction","detail":"{read_only:false; response_revision:15095; number_of_response:1; }","duration":"181.595151ms","start":"2026-08-22T13:28:08.696026Z","end":"2026-08-22T13:28:08.877621Z","steps":["trace[234807427] 'process raft request'  (duration: 127.720864ms)","trace[234807427] 'compare'  (duration: 53.692813ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:28:34.007012Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12812}
{"level":"info","ts":"2026-08-22T13:28:34.085862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12812,"took":"76.035087ms","hash":888771114,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":30777344,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-22T13:28:34.085928Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":888771114,"revision":12812,"compact-revision":10646}
{"level":"info","ts":"2026-08-22T13:29:21.791111Z","caller":"traceutil/trace.go:171","msg":"trace[1432305240] transaction","detail":"{read_only:false; response_revision:15568; number_of_response:1; }","duration":"140.534567ms","start":"2026-08-22T13:29:21.650483Z","end":"2026-08-22T13:29:21.791079Z","steps":["trace[1432305240] 'process raft request'  (duration: 119.901756ms)","trace[1432305240] 'compare'  (duration: 20.327085ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:33:34.014213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15224}
{"level":"info","ts":"2026-08-22T13:33:34.111807Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15224,"took":"94.545271ms","hash":214425120,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":31920128,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-22T13:33:34.111899Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":214425120,"revision":15224,"compact-revision":12812}
{"level":"warn","ts":"2026-08-22T13:33:59.63947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.979083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-22T13:33:59.639742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.879721ms","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-08-22T13:33:59.639798Z","caller":"traceutil/trace.go:171","msg":"trace[1385732223] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17699; }","duration":"144.966662ms","start":"2026-08-22T13:33:59.494818Z","end":"2026-08-22T13:33:59.639784Z","steps":["trace[1385732223] 'range keys from in-memory index tree'  (duration: 144.685238ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:33:59.6396Z","caller":"traceutil/trace.go:171","msg":"trace[1116297125] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:17699; }","duration":"167.164886ms","start":"2026-08-22T13:33:59.472408Z","end":"2026-08-22T13:33:59.639573Z","steps":["trace[1116297125] 'count revisions from in-memory index tree'  (duration: 166.897461ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:33:59.639839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.631546ms","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-08-22T13:33:59.640243Z","caller":"traceutil/trace.go:171","msg":"trace[1023001706] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17699; }","duration":"410.082154ms","start":"2026-08-22T13:33:59.230135Z","end":"2026-08-22T13:33:59.640218Z","steps":["trace[1023001706] 'range keys from in-memory index tree'  (duration: 409.242648ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:33:59.640296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:33:59.230112Z","time spent":"410.170245ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-08-22T13:33:59.679905Z","caller":"traceutil/trace.go:171","msg":"trace[1415536007] transaction","detail":"{read_only:false; response_revision:17700; number_of_response:1; }","duration":"182.554539ms","start":"2026-08-22T13:33:59.497314Z","end":"2026-08-22T13:33:59.679869Z","steps":["trace[1415536007] 'process raft request'  (duration: 182.373475ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:33:59.680104Z","caller":"traceutil/trace.go:171","msg":"trace[548898425] linearizableReadLoop","detail":"{readStateIndex:18298; appliedIndex:18297; }","duration":"164.204978ms","start":"2026-08-22T13:33:59.515628Z","end":"2026-08-22T13:33:59.679833Z","steps":["trace[548898425] 'read index received'  (duration: 164.039235ms)","trace[548898425] 'applied index is now lower than readState.Index'  (duration: 164.633µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:33:59.680098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.419274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:33:59.680188Z","caller":"traceutil/trace.go:171","msg":"trace[465048348] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:17700; }","duration":"164.576206ms","start":"2026-08-22T13:33:59.515588Z","end":"2026-08-22T13:33:59.680164Z","steps":["trace[465048348] 'agreement among raft nodes before linearized reading'  (duration: 164.367921ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:37:20.865694Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-22T13:37:20.870918Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-22T13:37:20.8712Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-22T13:38:34.020392Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17530}
{"level":"info","ts":"2026-08-22T13:38:34.1154Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17530,"took":"91.075266ms","hash":1400658041,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":34697216,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-22T13:38:34.11547Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1400658041,"revision":17530,"compact-revision":15224}
{"level":"info","ts":"2026-08-22T13:39:34.942028Z","caller":"traceutil/trace.go:171","msg":"trace[1920133632] transaction","detail":"{read_only:false; response_revision:20324; number_of_response:1; }","duration":"117.173114ms","start":"2026-08-22T13:39:34.824829Z","end":"2026-08-22T13:39:34.942002Z","steps":["trace[1920133632] 'process raft request'  (duration: 117.024171ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:39:45.425776Z","caller":"traceutil/trace.go:171","msg":"trace[872405448] transaction","detail":"{read_only:false; response_revision:20379; number_of_response:1; }","duration":"127.352788ms","start":"2026-08-22T13:39:45.298396Z","end":"2026-08-22T13:39:45.425749Z","steps":["trace[872405448] 'process raft request'  (duration: 127.126664ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:39:51.213761Z","caller":"traceutil/trace.go:171","msg":"trace[1198195310] transaction","detail":"{read_only:false; response_revision:20409; number_of_response:1; }","duration":"134.8002ms","start":"2026-08-22T13:39:51.078934Z","end":"2026-08-22T13:39:51.213735Z","steps":["trace[1198195310] 'process raft request'  (duration: 121.290482ms)","trace[1198195310] 'compare'  (duration: 13.383546ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:39:51.831481Z","caller":"traceutil/trace.go:171","msg":"trace[1274217690] transaction","detail":"{read_only:false; response_revision:20414; number_of_response:1; }","duration":"131.053139ms","start":"2026-08-22T13:39:51.700397Z","end":"2026-08-22T13:39:51.83145Z","steps":["trace[1274217690] 'process raft request'  (duration: 90.009646ms)","trace[1274217690] 'compare'  (duration: 40.90145ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:39:51.926184Z","caller":"traceutil/trace.go:171","msg":"trace[1538763232] linearizableReadLoop","detail":"{readStateIndex:21102; appliedIndex:21100; }","duration":"196.518918ms","start":"2026-08-22T13:39:51.729641Z","end":"2026-08-22T13:39:51.92616Z","steps":["trace[1538763232] 'read index received'  (duration: 60.78689ms)","trace[1538763232] 'applied index is now lower than readState.Index'  (duration: 135.730658ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:39:51.92651Z","caller":"traceutil/trace.go:171","msg":"trace[1503182187] transaction","detail":"{read_only:false; response_revision:20415; number_of_response:1; }","duration":"222.708866ms","start":"2026-08-22T13:39:51.703788Z","end":"2026-08-22T13:39:51.926497Z","steps":["trace[1503182187] 'process raft request'  (duration: 222.243116ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:39:51.92688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.2136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-22T13:39:51.926934Z","caller":"traceutil/trace.go:171","msg":"trace[218774065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20415; }","duration":"197.330253ms","start":"2026-08-22T13:39:51.729593Z","end":"2026-08-22T13:39:51.926923Z","steps":["trace[218774065] 'agreement among raft nodes before linearized reading'  (duration: 197.15109ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:39:51.92737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.366913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-22T13:39:51.927414Z","caller":"traceutil/trace.go:171","msg":"trace[1908521228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20415; }","duration":"197.429135ms","start":"2026-08-22T13:39:51.729974Z","end":"2026-08-22T13:39:51.927403Z","steps":["trace[1908521228] 'agreement among raft nodes before linearized reading'  (duration: 197.317113ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:39:51.92778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.532046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-22T13:39:51.927827Z","caller":"traceutil/trace.go:171","msg":"trace[114570009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20415; }","duration":"197.648078ms","start":"2026-08-22T13:39:51.73017Z","end":"2026-08-22T13:39:51.927818Z","steps":["trace[114570009] 'agreement among raft nodes before linearized reading'  (duration: 197.543206ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:43:34.025411Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19986}
{"level":"info","ts":"2026-08-22T13:43:34.185135Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19986,"took":"156.529923ms","hash":1752450081,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":39444480,"current-db-size-in-use":"39 MB"}
{"level":"info","ts":"2026-08-22T13:43:34.185184Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1752450081,"revision":19986,"compact-revision":17530}
{"level":"warn","ts":"2026-08-22T13:43:41.80947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.115034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:43:41.809572Z","caller":"traceutil/trace.go:171","msg":"trace[2006606886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22864; }","duration":"211.253566ms","start":"2026-08-22T13:43:41.598298Z","end":"2026-08-22T13:43:41.809552Z","steps":["trace[2006606886] 'range keys from in-memory index tree'  (duration: 211.051493ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:43:41.811185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.146937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" ","response":"range_response_count:1 size:626"}
{"level":"info","ts":"2026-08-22T13:43:41.811242Z","caller":"traceutil/trace.go:171","msg":"trace[1101799954] range","detail":"{range_begin:/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi; range_end:; response_count:1; response_revision:22864; }","duration":"122.268599ms","start":"2026-08-22T13:43:41.68896Z","end":"2026-08-22T13:43:41.811229Z","steps":["trace[1101799954] 'range keys from in-memory index tree'  (duration: 119.842384ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:46:08.232555Z","caller":"traceutil/trace.go:171","msg":"trace[1649709019] transaction","detail":"{read_only:false; response_revision:24346; number_of_response:1; }","duration":"114.867029ms","start":"2026-08-22T13:46:08.117663Z","end":"2026-08-22T13:46:08.23253Z","steps":["trace[1649709019] 'process raft request'  (duration: 114.710566ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:19.442984Z","caller":"traceutil/trace.go:171","msg":"trace[1974946435] transaction","detail":"{read_only:false; response_revision:25047; number_of_response:1; }","duration":"228.228678ms","start":"2026-08-22T13:47:19.214731Z","end":"2026-08-22T13:47:19.44296Z","steps":["trace[1974946435] 'process raft request'  (duration: 228.068485ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:19.460727Z","caller":"traceutil/trace.go:171","msg":"trace[848327012] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"209.225508ms","start":"2026-08-22T13:47:19.251471Z","end":"2026-08-22T13:47:19.460696Z","steps":["trace[848327012] 'process raft request'  (duration: 209.030403ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:19.612985Z","caller":"traceutil/trace.go:171","msg":"trace[1056554401] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"119.461167ms","start":"2026-08-22T13:47:19.493494Z","end":"2026-08-22T13:47:19.612955Z","steps":["trace[1056554401] 'process raft request'  (duration: 107.457928ms)","trace[1056554401] 'compare'  (duration: 11.690523ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:19.613027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.811421ms","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-08-22T13:47:19.613128Z","caller":"traceutil/trace.go:171","msg":"trace[1708530917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25048; }","duration":"132.965234ms","start":"2026-08-22T13:47:19.480136Z","end":"2026-08-22T13:47:19.613102Z","steps":["trace[1708530917] 'range keys from in-memory index tree'  (duration: 132.559466ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:19.886803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.169214ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140252 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25030 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:19.886908Z","caller":"traceutil/trace.go:171","msg":"trace[671615219] linearizableReadLoop","detail":"{readStateIndex:25865; appliedIndex:25863; }","duration":"286.625572ms","start":"2026-08-22T13:47:19.600265Z","end":"2026-08-22T13:47:19.886891Z","steps":["trace[671615219] 'read index received'  (duration: 651.933µs)","trace[671615219] 'applied index is now lower than readState.Index'  (duration: 285.972439ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:19.886972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.716245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:19.886997Z","caller":"traceutil/trace.go:171","msg":"trace[707296228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25050; }","duration":"286.780345ms","start":"2026-08-22T13:47:19.600207Z","end":"2026-08-22T13:47:19.886987Z","steps":["trace[707296228] 'agreement among raft nodes before linearized reading'  (duration: 286.729554ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:19.887098Z","caller":"traceutil/trace.go:171","msg":"trace[223757877] transaction","detail":"{read_only:false; response_revision:25050; number_of_response:1; }","duration":"351.226043ms","start":"2026-08-22T13:47:19.53584Z","end":"2026-08-22T13:47:19.887066Z","steps":["trace[223757877] 'process raft request'  (duration: 213.705383ms)","trace[223757877] 'compare'  (duration: 137.031881ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:19.887434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:19.535813Z","time spent":"351.488449ms","remote":"127.0.0.1:45398","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:25030 > 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-08-22T13:47:20.159436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.810796ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140253 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25029 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:20.159632Z","caller":"traceutil/trace.go:171","msg":"trace[656505597] linearizableReadLoop","detail":"{readStateIndex:25868; appliedIndex:25865; }","duration":"270.079767ms","start":"2026-08-22T13:47:19.889535Z","end":"2026-08-22T13:47:20.159615Z","steps":["trace[656505597] 'read index received'  (duration: 100.998915ms)","trace[656505597] 'applied index is now lower than readState.Index'  (duration: 169.079832ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:20.159628Z","caller":"traceutil/trace.go:171","msg":"trace[1173961487] transaction","detail":"{read_only:false; response_revision:25051; number_of_response:1; }","duration":"539.934919ms","start":"2026-08-22T13:47:19.61966Z","end":"2026-08-22T13:47:20.159595Z","steps":["trace[1173961487] 'process raft request'  (duration: 370.862508ms)","trace[1173961487] 'compare'  (duration: 168.709884ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:20.159783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:19.619627Z","time spent":"540.071481ms","remote":"127.0.0.1:45398","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:25029 > 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-08-22T13:47:20.159846Z","caller":"traceutil/trace.go:171","msg":"trace[648323102] transaction","detail":"{read_only:false; response_revision:25052; number_of_response:1; }","duration":"458.431697ms","start":"2026-08-22T13:47:19.701396Z","end":"2026-08-22T13:47:20.159828Z","steps":["trace[648323102] 'process raft request'  (duration: 458.128271ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:20.159945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:19.701366Z","time spent":"458.526818ms","remote":"127.0.0.1:45398","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:25031 > 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-08-22T13:47:20.160086Z","caller":"traceutil/trace.go:171","msg":"trace[946150236] transaction","detail":"{read_only:false; response_revision:25053; number_of_response:1; }","duration":"456.01638ms","start":"2026-08-22T13:47:19.704058Z","end":"2026-08-22T13:47:20.160075Z","steps":["trace[946150236] 'process raft request'  (duration: 455.518251ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:20.16014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:19.70405Z","time spent":"456.056851ms","remote":"127.0.0.1:45398","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:25032 > 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-08-22T13:47:20.160139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.575206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-22T13:47:20.160151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.120953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"}
{"level":"info","ts":"2026-08-22T13:47:20.16022Z","caller":"traceutil/trace.go:171","msg":"trace[1883991670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25053; }","duration":"270.701168ms","start":"2026-08-22T13:47:19.889498Z","end":"2026-08-22T13:47:20.160199Z","steps":["trace[1883991670] 'agreement among raft nodes before linearized reading'  (duration: 270.547495ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:20.160223Z","caller":"traceutil/trace.go:171","msg":"trace[563105773] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25053; }","duration":"264.221555ms","start":"2026-08-22T13:47:19.895983Z","end":"2026-08-22T13:47:20.160205Z","steps":["trace[563105773] 'agreement among raft nodes before linearized reading'  (duration: 264.001881ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:20.352182Z","caller":"traceutil/trace.go:171","msg":"trace[1339405184] linearizableReadLoop","detail":"{readStateIndex:25869; appliedIndex:25868; }","duration":"183.785563ms","start":"2026-08-22T13:47:20.168372Z","end":"2026-08-22T13:47:20.352157Z","steps":["trace[1339405184] 'read index received'  (duration: 139.54329ms)","trace[1339405184] 'applied index is now lower than readState.Index'  (duration: 44.241233ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:20.352277Z","caller":"traceutil/trace.go:171","msg":"trace[362400041] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"186.760819ms","start":"2026-08-22T13:47:20.165475Z","end":"2026-08-22T13:47:20.352236Z","steps":["trace[362400041] 'process raft request'  (duration: 142.453075ms)","trace[362400041] 'compare'  (duration: 44.07954ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:20.352419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.026547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"}
{"level":"info","ts":"2026-08-22T13:47:20.352518Z","caller":"traceutil/trace.go:171","msg":"trace[1739030797] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25054; }","duration":"184.137969ms","start":"2026-08-22T13:47:20.168341Z","end":"2026-08-22T13:47:20.352479Z","steps":["trace[1739030797] 'agreement among raft nodes before linearized reading'  (duration: 183.899254ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:20.514833Z","caller":"traceutil/trace.go:171","msg":"trace[1105524580] transaction","detail":"{read_only:false; response_revision:25055; number_of_response:1; }","duration":"158.129554ms","start":"2026-08-22T13:47:20.35666Z","end":"2026-08-22T13:47:20.51479Z","steps":["trace[1105524580] 'process raft request'  (duration: 126.43966ms)","trace[1105524580] 'compare'  (duration: 31.440969ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:20.514953Z","caller":"traceutil/trace.go:171","msg":"trace[532697384] linearizableReadLoop","detail":"{readStateIndex:25871; appliedIndex:25869; }","duration":"149.06391ms","start":"2026-08-22T13:47:20.365859Z","end":"2026-08-22T13:47:20.514923Z","steps":["trace[532697384] 'read index received'  (duration: 117.339046ms)","trace[532697384] 'applied index is now lower than readState.Index'  (duration: 31.722974ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:20.51501Z","caller":"traceutil/trace.go:171","msg":"trace[1581723465] transaction","detail":"{read_only:false; response_revision:25056; number_of_response:1; }","duration":"158.044402ms","start":"2026-08-22T13:47:20.356926Z","end":"2026-08-22T13:47:20.51497Z","steps":["trace[1581723465] 'process raft request'  (duration: 157.819168ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:20.515206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.326045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-22T13:47:20.515287Z","caller":"traceutil/trace.go:171","msg":"trace[609452297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25056; }","duration":"149.436988ms","start":"2026-08-22T13:47:20.365832Z","end":"2026-08-22T13:47:20.515269Z","steps":["trace[609452297] 'agreement among raft nodes before linearized reading'  (duration: 149.188733ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:20.768474Z","caller":"traceutil/trace.go:171","msg":"trace[1439934985] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"249.143768ms","start":"2026-08-22T13:47:20.519301Z","end":"2026-08-22T13:47:20.768444Z","steps":["trace[1439934985] 'process raft request'  (duration: 162.547887ms)","trace[1439934985] 'compare'  (duration: 86.360996ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:21.140165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.790718ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140268 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25044 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:21.140372Z","caller":"traceutil/trace.go:171","msg":"trace[1400054754] linearizableReadLoop","detail":"{readStateIndex:25875; appliedIndex:25872; }","duration":"285.386688ms","start":"2026-08-22T13:47:20.854968Z","end":"2026-08-22T13:47:21.140355Z","steps":["trace[1400054754] 'read index received'  (duration: 43.332636ms)","trace[1400054754] 'applied index is now lower than readState.Index'  (duration: 242.053132ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:21.140436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.46584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:21.140464Z","caller":"traceutil/trace.go:171","msg":"trace[139833004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25060; }","duration":"285.564692ms","start":"2026-08-22T13:47:20.85489Z","end":"2026-08-22T13:47:21.140455Z","steps":["trace[139833004] 'agreement among raft nodes before linearized reading'  (duration: 285.513481ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:21.140459Z","caller":"traceutil/trace.go:171","msg":"trace[1861568905] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"341.044099ms","start":"2026-08-22T13:47:20.799382Z","end":"2026-08-22T13:47:21.140426Z","steps":["trace[1861568905] 'process raft request'  (duration: 340.880666ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:21.14063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:20.799352Z","time spent":"341.192392ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25045 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-22T13:47:21.14064Z","caller":"traceutil/trace.go:171","msg":"trace[966631250] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"335.452923ms","start":"2026-08-22T13:47:20.805164Z","end":"2026-08-22T13:47:21.140617Z","steps":["trace[966631250] 'process raft request'  (duration: 335.149527ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:21.14066Z","caller":"traceutil/trace.go:171","msg":"trace[871397588] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"459.032737ms","start":"2026-08-22T13:47:20.681602Z","end":"2026-08-22T13:47:21.140635Z","steps":["trace[871397588] 'process raft request'  (duration: 216.678059ms)","trace[871397588] 'compare'  (duration: 241.630055ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:21.140752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:20.681574Z","time spent":"459.127429ms","remote":"127.0.0.1:45398","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:25044 > 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":"warn","ts":"2026-08-22T13:47:21.140791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:20.805129Z","time spent":"335.566544ms","remote":"127.0.0.1:45398","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/capi-system/controller-leader-election-capi\" mod_revision:25046 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-22T13:47:21.823829Z","caller":"traceutil/trace.go:171","msg":"trace[829677198] linearizableReadLoop","detail":"{readStateIndex:25878; appliedIndex:25875; }","duration":"351.12867ms","start":"2026-08-22T13:47:21.472682Z","end":"2026-08-22T13:47:21.823811Z","steps":["trace[829677198] 'read index received'  (duration: 21.107851ms)","trace[829677198] 'applied index is now lower than readState.Index'  (duration: 330.019959ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:21.823946Z","caller":"traceutil/trace.go:171","msg":"trace[736090227] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"375.564806ms","start":"2026-08-22T13:47:21.448346Z","end":"2026-08-22T13:47:21.823911Z","steps":["trace[736090227] 'process raft request'  (duration: 375.300101ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:21.824019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.312814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-22T13:47:21.82404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.307168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-08-22T13:47:21.82403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.923493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:21.824076Z","caller":"traceutil/trace.go:171","msg":"trace[1537705997] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25063; }","duration":"336.39264ms","start":"2026-08-22T13:47:21.487674Z","end":"2026-08-22T13:47:21.824066Z","steps":["trace[1537705997] 'agreement among raft nodes before linearized reading'  (duration: 336.245607ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:21.824094Z","caller":"traceutil/trace.go:171","msg":"trace[8245416] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:25063; }","duration":"351.418766ms","start":"2026-08-22T13:47:21.472643Z","end":"2026-08-22T13:47:21.824062Z","steps":["trace[8245416] 'agreement among raft nodes before linearized reading'  (duration: 351.271993ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:21.824102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:21.487651Z","time spent":"336.444271ms","remote":"127.0.0.1:45312","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-08-22T13:47:21.824105Z","caller":"traceutil/trace.go:171","msg":"trace[2124044274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25063; }","duration":"228.042875ms","start":"2026-08-22T13:47:21.596043Z","end":"2026-08-22T13:47:21.824086Z","steps":["trace[2124044274] 'agreement among raft nodes before linearized reading'  (duration: 227.918353ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:21.824116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:21.448322Z","time spent":"375.705389ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25047 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:21.824131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:21.472624Z","time spent":"351.501017ms","remote":"127.0.0.1:58862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":142,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true "}
{"level":"info","ts":"2026-08-22T13:47:21.82437Z","caller":"traceutil/trace.go:171","msg":"trace[935760092] transaction","detail":"{read_only:false; response_revision:25063; number_of_response:1; }","duration":"359.133753ms","start":"2026-08-22T13:47:21.465224Z","end":"2026-08-22T13:47:21.824358Z","steps":["trace[935760092] 'process raft request'  (duration: 358.549293ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:21.824456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:21.465197Z","time spent":"359.203574ms","remote":"127.0.0.1:45398","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:25048 > 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-08-22T13:47:22.187837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.628898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:22.187938Z","caller":"traceutil/trace.go:171","msg":"trace[1905256994] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25064; }","duration":"131.779191ms","start":"2026-08-22T13:47:22.056132Z","end":"2026-08-22T13:47:22.187911Z","steps":["trace[1905256994] 'count revisions from in-memory index tree'  (duration: 131.542066ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:22.269436Z","caller":"traceutil/trace.go:171","msg":"trace[180367310] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"104.613313ms","start":"2026-08-22T13:47:22.164699Z","end":"2026-08-22T13:47:22.269313Z","steps":["trace[180367310] 'process raft request'  (duration: 104.41608ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:22.28328Z","caller":"traceutil/trace.go:171","msg":"trace[1942415476] transaction","detail":"{read_only:false; response_revision:25066; number_of_response:1; }","duration":"117.983198ms","start":"2026-08-22T13:47:22.165271Z","end":"2026-08-22T13:47:22.283254Z","steps":["trace[1942415476] 'process raft request'  (duration: 117.744764ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:22.622952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.047739ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140292 > lease_revoke:<id:414ba0298d2eaa01>","response":"size:29"}
{"level":"info","ts":"2026-08-22T13:47:22.623088Z","caller":"traceutil/trace.go:171","msg":"trace[1740564301] linearizableReadLoop","detail":"{readStateIndex:25883; appliedIndex:25882; }","duration":"265.667711ms","start":"2026-08-22T13:47:22.357401Z","end":"2026-08-22T13:47:22.623069Z","steps":["trace[1740564301] 'read index received'  (duration: 72.430639ms)","trace[1740564301] 'applied index is now lower than readState.Index'  (duration: 193.235402ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:22.62336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.24376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-22T13:47:22.623399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.990349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-08-22T13:47:22.623404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.562024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-08-22T13:47:22.623425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.652316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-22T13:47:22.623453Z","caller":"traceutil/trace.go:171","msg":"trace[981287268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25067; }","duration":"266.09653ms","start":"2026-08-22T13:47:22.357344Z","end":"2026-08-22T13:47:22.623441Z","steps":["trace[981287268] 'agreement among raft nodes before linearized reading'  (duration: 265.875115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:22.623465Z","caller":"traceutil/trace.go:171","msg":"trace[346993428] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25067; }","duration":"103.680706ms","start":"2026-08-22T13:47:22.51977Z","end":"2026-08-22T13:47:22.623451Z","steps":["trace[346993428] 'agreement among raft nodes before linearized reading'  (duration: 103.491081ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:22.623462Z","caller":"traceutil/trace.go:171","msg":"trace[250178105] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:25067; }","duration":"206.386183ms","start":"2026-08-22T13:47:22.41705Z","end":"2026-08-22T13:47:22.623436Z","steps":["trace[250178105] 'agreement among raft nodes before linearized reading'  (duration: 206.217669ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:22.623497Z","caller":"traceutil/trace.go:171","msg":"trace[1268816214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25067; }","duration":"103.762137ms","start":"2026-08-22T13:47:22.519714Z","end":"2026-08-22T13:47:22.623476Z","steps":["trace[1268816214] 'agreement among raft nodes before linearized reading'  (duration: 103.550922ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:23.017396Z","caller":"traceutil/trace.go:171","msg":"trace[876149873] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"389.762127ms","start":"2026-08-22T13:47:22.627609Z","end":"2026-08-22T13:47:23.017371Z","steps":["trace[876149873] 'process raft request'  (duration: 389.600054ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:23.017558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:22.627587Z","time spent":"389.877289ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25055 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:23.190479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.450217ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140297 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25056 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:23.190647Z","caller":"traceutil/trace.go:171","msg":"trace[382516044] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"562.919317ms","start":"2026-08-22T13:47:22.627705Z","end":"2026-08-22T13:47:23.190624Z","steps":["trace[382516044] 'process raft request'  (duration: 413.240565ms)","trace[382516044] 'compare'  (duration: 149.318685ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:23.190796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:22.62768Z","time spent":"563.044058ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25056 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-22T13:47:23.190968Z","caller":"traceutil/trace.go:171","msg":"trace[568458330] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"562.802105ms","start":"2026-08-22T13:47:22.628148Z","end":"2026-08-22T13:47:23.19095Z","steps":["trace[568458330] 'process raft request'  (duration: 562.419117ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:23.191039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:22.628128Z","time spent":"562.873096ms","remote":"127.0.0.1:45398","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:25054 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-22T13:47:23.191122Z","caller":"traceutil/trace.go:171","msg":"trace[1742774654] linearizableReadLoop","detail":"{readStateIndex:25886; appliedIndex:25883; }","duration":"418.342511ms","start":"2026-08-22T13:47:22.77276Z","end":"2026-08-22T13:47:23.191102Z","steps":["trace[1742774654] 'read index received'  (duration: 244.508849ms)","trace[1742774654] 'applied index is now lower than readState.Index'  (duration: 173.830642ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:23.191311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.544815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-22T13:47:23.191343Z","caller":"traceutil/trace.go:171","msg":"trace[1917727724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25072; }","duration":"418.615487ms","start":"2026-08-22T13:47:22.772718Z","end":"2026-08-22T13:47:23.191334Z","steps":["trace[1917727724] 'agreement among raft nodes before linearized reading'  (duration: 418.444764ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:23.191372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:22.772697Z","time spent":"418.668677ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-22T13:47:23.714245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.290876ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140303 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25057 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:23.714397Z","caller":"traceutil/trace.go:171","msg":"trace[1264411347] linearizableReadLoop","detail":"{readStateIndex:25890; appliedIndex:25889; }","duration":"481.816091ms","start":"2026-08-22T13:47:23.232556Z","end":"2026-08-22T13:47:23.714372Z","steps":["trace[1264411347] 'read index received'  (duration: 280.282011ms)","trace[1264411347] 'applied index is now lower than readState.Index'  (duration: 201.53188ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:23.71453Z","caller":"traceutil/trace.go:171","msg":"trace[221481791] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"518.285506ms","start":"2026-08-22T13:47:23.196194Z","end":"2026-08-22T13:47:23.71448Z","steps":["trace[221481791] 'process raft request'  (duration: 316.618973ms)","trace[221481791] 'compare'  (duration: 201.078192ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:23.714885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.047291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-22T13:47:23.714909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.997924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-22T13:47:23.71495Z","caller":"traceutil/trace.go:171","msg":"trace[260054426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25074; }","duration":"116.162023ms","start":"2026-08-22T13:47:23.598773Z","end":"2026-08-22T13:47:23.714935Z","steps":["trace[260054426] 'agreement among raft nodes before linearized reading'  (duration: 116.03495ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:23.71458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.994685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:23.714965Z","caller":"traceutil/trace.go:171","msg":"trace[310051355] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:25074; }","duration":"461.090356ms","start":"2026-08-22T13:47:23.253856Z","end":"2026-08-22T13:47:23.714946Z","steps":["trace[310051355] 'agreement among raft nodes before linearized reading'  (duration: 460.955923ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:23.715033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:23.253839Z","time spent":"461.181027ms","remote":"127.0.0.1:34424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "}
{"level":"info","ts":"2026-08-22T13:47:23.715034Z","caller":"traceutil/trace.go:171","msg":"trace[1748623372] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25074; }","duration":"482.496694ms","start":"2026-08-22T13:47:23.232494Z","end":"2026-08-22T13:47:23.714991Z","steps":["trace[1748623372] 'agreement among raft nodes before linearized reading'  (duration: 481.993394ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:23.715109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:23.232476Z","time spent":"482.606376ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "}
{"level":"warn","ts":"2026-08-22T13:47:23.715476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:23.196166Z","time spent":"518.714215ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25057 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:24.057613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.065069ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140307 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25062 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:24.057853Z","caller":"traceutil/trace.go:171","msg":"trace[1383081967] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"228.78038ms","start":"2026-08-22T13:47:23.829043Z","end":"2026-08-22T13:47:24.057823Z","steps":["trace[1383081967] 'process raft request'  (duration: 58.372603ms)","trace[1383081967] 'compare'  (duration: 169.908497ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:24.06564Z","caller":"traceutil/trace.go:171","msg":"trace[241494536] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"236.316193ms","start":"2026-08-22T13:47:23.829303Z","end":"2026-08-22T13:47:24.065619Z","steps":["trace[241494536] 'process raft request'  (duration: 236.16707ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:24.337931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.864721ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140309 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25064 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:24.338192Z","caller":"traceutil/trace.go:171","msg":"trace[53785965] linearizableReadLoop","detail":"{readStateIndex:25893; appliedIndex:25892; }","duration":"164.72841ms","start":"2026-08-22T13:47:24.173372Z","end":"2026-08-22T13:47:24.338101Z","steps":["trace[53785965] 'read index received'  (duration: 48.841µs)","trace[53785965] 'applied index is now lower than readState.Index'  (duration: 164.674838ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:24.338224Z","caller":"traceutil/trace.go:171","msg":"trace[573962164] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"417.708769ms","start":"2026-08-22T13:47:23.920477Z","end":"2026-08-22T13:47:24.338186Z","steps":["trace[573962164] 'process raft request'  (duration: 240.501952ms)","trace[573962164] 'compare'  (duration: 176.250568ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:24.338392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:23.920453Z","time spent":"417.850132ms","remote":"127.0.0.1:45398","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:25064 > 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-08-22T13:47:24.338437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.014975ms","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-08-22T13:47:24.338489Z","caller":"traceutil/trace.go:171","msg":"trace[250825359] 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:25078; }","duration":"165.153997ms","start":"2026-08-22T13:47:24.173315Z","end":"2026-08-22T13:47:24.338469Z","steps":["trace[250825359] 'agreement among raft nodes before linearized reading'  (duration: 165.004015ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:24.581521Z","caller":"traceutil/trace.go:171","msg":"trace[60056457] linearizableReadLoop","detail":"{readStateIndex:25895; appliedIndex:25894; }","duration":"243.221555ms","start":"2026-08-22T13:47:24.338274Z","end":"2026-08-22T13:47:24.581496Z","steps":["trace[60056457] 'read index received'  (duration: 242.98177ms)","trace[60056457] 'applied index is now lower than readState.Index'  (duration: 238.495µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:24.581666Z","caller":"traceutil/trace.go:171","msg":"trace[1048068784] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"292.690938ms","start":"2026-08-22T13:47:24.288955Z","end":"2026-08-22T13:47:24.581646Z","steps":["trace[1048068784] 'process raft request'  (duration: 292.33194ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:24.581952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.192397ms","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-08-22T13:47:24.581987Z","caller":"traceutil/trace.go:171","msg":"trace[489911180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25079; }","duration":"293.286699ms","start":"2026-08-22T13:47:24.28869Z","end":"2026-08-22T13:47:24.581976Z","steps":["trace[489911180] 'agreement among raft nodes before linearized reading'  (duration: 293.143486ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:29.446486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.74394ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140400 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25099 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:29.446641Z","caller":"traceutil/trace.go:171","msg":"trace[131551664] linearizableReadLoop","detail":"{readStateIndex:25933; appliedIndex:25932; }","duration":"233.431178ms","start":"2026-08-22T13:47:29.213171Z","end":"2026-08-22T13:47:29.446602Z","steps":["trace[131551664] 'read index received'  (duration: 91.447063ms)","trace[131551664] 'applied index is now lower than readState.Index'  (duration: 141.982685ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:29.446699Z","caller":"traceutil/trace.go:171","msg":"trace[1346495956] transaction","detail":"{read_only:false; response_revision:25116; number_of_response:1; }","duration":"237.061136ms","start":"2026-08-22T13:47:29.209566Z","end":"2026-08-22T13:47:29.446627Z","steps":["trace[1346495956] 'process raft request'  (duration: 95.036461ms)","trace[1346495956] 'compare'  (duration: 141.546506ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:29.447194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.016029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-22T13:47:29.447278Z","caller":"traceutil/trace.go:171","msg":"trace[886791561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25116; }","duration":"234.130921ms","start":"2026-08-22T13:47:29.213135Z","end":"2026-08-22T13:47:29.447266Z","steps":["trace[886791561] 'agreement among raft nodes before linearized reading'  (duration: 233.660403ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:29.469278Z","caller":"traceutil/trace.go:171","msg":"trace[1944954206] transaction","detail":"{read_only:false; response_revision:25117; number_of_response:1; }","duration":"254.922138ms","start":"2026-08-22T13:47:29.214302Z","end":"2026-08-22T13:47:29.469224Z","steps":["trace[1944954206] 'process raft request'  (duration: 254.672403ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:29.469324Z","caller":"traceutil/trace.go:171","msg":"trace[1724939742] transaction","detail":"{read_only:false; response_revision:25118; number_of_response:1; }","duration":"254.471029ms","start":"2026-08-22T13:47:29.214817Z","end":"2026-08-22T13:47:29.469288Z","steps":["trace[1724939742] 'process raft request'  (duration: 254.321056ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:29.469406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.377799ms","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-08-22T13:47:29.469521Z","caller":"traceutil/trace.go:171","msg":"trace[1272138085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25118; }","duration":"252.521952ms","start":"2026-08-22T13:47:29.216968Z","end":"2026-08-22T13:47:29.46949Z","steps":["trace[1272138085] 'agreement among raft nodes before linearized reading'  (duration: 252.230746ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:29.469575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.187191ms","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-08-22T13:47:29.469651Z","caller":"traceutil/trace.go:171","msg":"trace[1963820901] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:25118; }","duration":"183.343163ms","start":"2026-08-22T13:47:29.286288Z","end":"2026-08-22T13:47:29.469631Z","steps":["trace[1963820901] 'agreement among raft nodes before linearized reading'  (duration: 183.197841ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:29.696193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.637587ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140404 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25102 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:29.696627Z","caller":"traceutil/trace.go:171","msg":"trace[1738804395] transaction","detail":"{read_only:false; response_revision:25119; number_of_response:1; }","duration":"245.265713ms","start":"2026-08-22T13:47:29.451332Z","end":"2026-08-22T13:47:29.696598Z","steps":["trace[1738804395] 'process raft request'  (duration: 132.053247ms)","trace[1738804395] 'compare'  (duration: 112.425452ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:29.697461Z","caller":"traceutil/trace.go:171","msg":"trace[750762328] transaction","detail":"{read_only:false; response_revision:25120; number_of_response:1; }","duration":"223.156982ms","start":"2026-08-22T13:47:29.47429Z","end":"2026-08-22T13:47:29.697447Z","steps":["trace[750762328] 'process raft request'  (duration: 222.268505ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:29.697658Z","caller":"traceutil/trace.go:171","msg":"trace[243078970] linearizableReadLoop","detail":"{readStateIndex:25937; appliedIndex:25935; }","duration":"100.021057ms","start":"2026-08-22T13:47:29.597613Z","end":"2026-08-22T13:47:29.697634Z","steps":["trace[243078970] 'read index received'  (duration: 96.339506ms)","trace[243078970] 'applied index is now lower than readState.Index'  (duration: 3.676811ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:29.697802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.166429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:29.697835Z","caller":"traceutil/trace.go:171","msg":"trace[822539360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25121; }","duration":"100.24875ms","start":"2026-08-22T13:47:29.597579Z","end":"2026-08-22T13:47:29.697828Z","steps":["trace[822539360] 'agreement among raft nodes before linearized reading'  (duration: 100.158389ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.132609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.369713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:37.132708Z","caller":"traceutil/trace.go:171","msg":"trace[1309779264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25171; }","duration":"534.507035ms","start":"2026-08-22T13:47:36.598181Z","end":"2026-08-22T13:47:37.132688Z","steps":["trace[1309779264] 'range keys from in-memory index tree'  (duration: 534.254071ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.132751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:36.598166Z","time spent":"534.575567ms","remote":"127.0.0.1:45124","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-08-22T13:47:37.132891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.701803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:37.132938Z","caller":"traceutil/trace.go:171","msg":"trace[2036500193] linearizableReadLoop","detail":"{readStateIndex:25990; appliedIndex:25989; }","duration":"471.248869ms","start":"2026-08-22T13:47:36.661661Z","end":"2026-08-22T13:47:37.132909Z","steps":["trace[2036500193] 'read index received'  (duration: 442.857649ms)","trace[2036500193] 'applied index is now lower than readState.Index'  (duration: 28.39016ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:37.132964Z","caller":"traceutil/trace.go:171","msg":"trace[1248035191] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:25171; }","duration":"530.849126ms","start":"2026-08-22T13:47:36.602101Z","end":"2026-08-22T13:47:37.13295Z","steps":["trace[1248035191] 'count revisions from in-memory index tree'  (duration: 530.6074ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.133004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:36.60208Z","time spent":"530.914707ms","remote":"127.0.0.1:58706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true "}
{"level":"info","ts":"2026-08-22T13:47:37.133184Z","caller":"traceutil/trace.go:171","msg":"trace[1783713841] transaction","detail":"{read_only:false; response_revision:25172; number_of_response:1; }","duration":"488.193212ms","start":"2026-08-22T13:47:36.644977Z","end":"2026-08-22T13:47:37.13317Z","steps":["trace[1783713841] 'process raft request'  (duration: 459.619838ms)","trace[1783713841] 'compare'  (duration: 27.365222ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:37.133289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:36.644952Z","time spent":"488.270314ms","remote":"127.0.0.1:45398","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:25157 > 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-08-22T13:47:37.133544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.891261ms","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-08-22T13:47:37.133587Z","caller":"traceutil/trace.go:171","msg":"trace[1878175863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25172; }","duration":"471.972633ms","start":"2026-08-22T13:47:36.661603Z","end":"2026-08-22T13:47:37.133575Z","steps":["trace[1878175863] 'agreement among raft nodes before linearized reading'  (duration: 471.83045ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.13363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:36.661581Z","time spent":"472.042055ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-22T13:47:37.13374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.775285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"warn","ts":"2026-08-22T13:47:37.133589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.28483ms","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":"warn","ts":"2026-08-22T13:47:37.133742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.868867ms","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":"info","ts":"2026-08-22T13:47:37.133783Z","caller":"traceutil/trace.go:171","msg":"trace[188237352] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:25172; }","duration":"137.841997ms","start":"2026-08-22T13:47:36.995931Z","end":"2026-08-22T13:47:37.133773Z","steps":["trace[188237352] 'agreement among raft nodes before linearized reading'  (duration: 137.682274ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:37.133833Z","caller":"traceutil/trace.go:171","msg":"trace[638260216] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25172; }","duration":"138.007739ms","start":"2026-08-22T13:47:36.9958Z","end":"2026-08-22T13:47:37.133808Z","steps":["trace[638260216] 'agreement among raft nodes before linearized reading'  (duration: 137.838296ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:37.133878Z","caller":"traceutil/trace.go:171","msg":"trace[2101499814] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:25172; }","duration":"165.560054ms","start":"2026-08-22T13:47:36.96825Z","end":"2026-08-22T13:47:37.13381Z","steps":["trace[2101499814] 'agreement among raft nodes before linearized reading'  (duration: 165.295669ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.419585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.442826ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140528 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:414ba0298d2eacef>","response":"size:41"}
{"level":"info","ts":"2026-08-22T13:47:37.740827Z","caller":"traceutil/trace.go:171","msg":"trace[1515921347] transaction","detail":"{read_only:false; response_revision:25173; number_of_response:1; }","duration":"603.334767ms","start":"2026-08-22T13:47:37.136059Z","end":"2026-08-22T13:47:37.739394Z","steps":["trace[1515921347] 'process raft request'  (duration: 603.043471ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:37.741198Z","caller":"traceutil/trace.go:171","msg":"trace[1612268800] transaction","detail":"{read_only:false; response_revision:25174; number_of_response:1; }","duration":"601.868347ms","start":"2026-08-22T13:47:37.137567Z","end":"2026-08-22T13:47:37.739435Z","steps":["trace[1612268800] 'process raft request'  (duration: 601.753785ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.741308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.137531Z","time spent":"603.695463ms","remote":"127.0.0.1:45398","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:25158 > 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-08-22T13:47:37.741368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.136029Z","time spent":"604.880616ms","remote":"127.0.0.1:45212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":939,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/neutron-dhcp-agent-default-shkpd.18ce2408b71fe97f\" mod_revision:24699 > success:<request_put:<key:\"/registry/events/openstack/neutron-dhcp-agent-default-shkpd.18ce2408b71fe97f\" value_size:845 lease:4705030336041363401 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-dhcp-agent-default-shkpd.18ce2408b71fe97f\" > >"}
{"level":"info","ts":"2026-08-22T13:47:37.741459Z","caller":"traceutil/trace.go:171","msg":"trace[1031705253] linearizableReadLoop","detail":"{readStateIndex:25993; appliedIndex:25990; }","duration":"598.328951ms","start":"2026-08-22T13:47:37.14305Z","end":"2026-08-22T13:47:37.741379Z","steps":["trace[1031705253] 'read index received'  (duration: 94.081272ms)","trace[1031705253] 'applied index is now lower than readState.Index'  (duration: 504.241659ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:37.741814Z","caller":"traceutil/trace.go:171","msg":"trace[1718496711] transaction","detail":"{read_only:false; response_revision:25175; number_of_response:1; }","duration":"586.74381ms","start":"2026-08-22T13:47:37.155041Z","end":"2026-08-22T13:47:37.741785Z","steps":["trace[1718496711] 'process raft request'  (duration: 584.351875ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.741983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.155019Z","time spent":"586.885233ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25096 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:37.742022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.940023ms","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-08-22T13:47:37.742189Z","caller":"traceutil/trace.go:171","msg":"trace[1070454996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25175; }","duration":"599.120135ms","start":"2026-08-22T13:47:37.142992Z","end":"2026-08-22T13:47:37.742112Z","steps":["trace[1070454996] 'agreement among raft nodes before linearized reading'  (duration: 598.528664ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:37.742257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.142971Z","time spent":"599.272709ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-22T13:47:38.241651Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13928402372896140536,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-22T13:47:38.386715Z","caller":"traceutil/trace.go:171","msg":"trace[379310944] transaction","detail":"{read_only:false; response_revision:25176; number_of_response:1; }","duration":"965.829712ms","start":"2026-08-22T13:47:37.420772Z","end":"2026-08-22T13:47:38.386602Z","steps":["trace[379310944] 'process raft request'  (duration: 915.83748ms)","trace[379310944] 'compare'  (duration: 49.709145ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:38.386737Z","caller":"traceutil/trace.go:171","msg":"trace[2095369986] transaction","detail":"{read_only:false; response_revision:25177; number_of_response:1; }","duration":"906.871509ms","start":"2026-08-22T13:47:37.479837Z","end":"2026-08-22T13:47:38.386709Z","steps":["trace[2095369986] 'process raft request'  (duration: 906.706024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.386913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.420736Z","time spent":"966.066676ms","remote":"127.0.0.1:45166","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.182\" mod_revision:25097 > success:<request_put:<key:\"/registry/masterleases/199.204.45.182\" value_size:68 lease:4705030336041364719 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.182\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:38.386929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.479809Z","time spent":"907.014311ms","remote":"127.0.0.1:45398","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:25161 > 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-08-22T13:47:38.387039Z","caller":"traceutil/trace.go:171","msg":"trace[1177346022] transaction","detail":"{read_only:false; response_revision:25178; number_of_response:1; }","duration":"887.05515ms","start":"2026-08-22T13:47:37.499954Z","end":"2026-08-22T13:47:38.387009Z","steps":["trace[1177346022] 'process raft request'  (duration: 886.679873ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.387241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.49993Z","time spent":"887.221184ms","remote":"127.0.0.1:45398","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/capi-system/controller-leader-election-capi\" mod_revision:25162 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-22T13:47:38.387525Z","caller":"traceutil/trace.go:171","msg":"trace[693315257] transaction","detail":"{read_only:false; response_revision:25179; number_of_response:1; }","duration":"884.607544ms","start":"2026-08-22T13:47:37.502907Z","end":"2026-08-22T13:47:38.387515Z","steps":["trace[693315257] 'process raft request'  (duration: 884.017883ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.387568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.502894Z","time spent":"884.649954ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25163 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-22T13:47:38.387818Z","caller":"traceutil/trace.go:171","msg":"trace[1496151670] transaction","detail":"{read_only:false; response_revision:25180; number_of_response:1; }","duration":"637.470025ms","start":"2026-08-22T13:47:37.75032Z","end":"2026-08-22T13:47:38.38779Z","steps":["trace[1496151670] 'process raft request'  (duration: 637.116188ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:38.387864Z","caller":"traceutil/trace.go:171","msg":"trace[1446562438] transaction","detail":"{read_only:false; response_revision:25181; number_of_response:1; }","duration":"257.155308ms","start":"2026-08-22T13:47:38.130684Z","end":"2026-08-22T13:47:38.38784Z","steps":["trace[1446562438] 'process raft request'  (duration: 257.032725ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.38794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.7503Z","time spent":"637.569906ms","remote":"127.0.0.1:45398","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:25160 > 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-08-22T13:47:38.387946Z","caller":"traceutil/trace.go:171","msg":"trace[180071790] transaction","detail":"{read_only:false; response_revision:25182; number_of_response:1; }","duration":"252.034689ms","start":"2026-08-22T13:47:38.135897Z","end":"2026-08-22T13:47:38.387932Z","steps":["trace[180071790] 'process raft request'  (duration: 251.904167ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:38.387961Z","caller":"traceutil/trace.go:171","msg":"trace[1728717557] linearizableReadLoop","detail":"{readStateIndex:26001; appliedIndex:25994; }","duration":"646.349754ms","start":"2026-08-22T13:47:37.741577Z","end":"2026-08-22T13:47:38.387926Z","steps":["trace[1728717557] 'read index received'  (duration: 595.076238ms)","trace[1728717557] 'applied index is now lower than readState.Index'  (duration: 51.270946ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:38.388076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.229649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:38.38812Z","caller":"traceutil/trace.go:171","msg":"trace[154975102] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:25182; }","duration":"818.312311ms","start":"2026-08-22T13:47:37.569791Z","end":"2026-08-22T13:47:38.388103Z","steps":["trace[154975102] 'agreement among raft nodes before linearized reading'  (duration: 818.232549ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.38813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.227983196s","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-08-22T13:47:38.388154Z","caller":"traceutil/trace.go:171","msg":"trace[338585778] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25182; }","duration":"1.228046818s","start":"2026-08-22T13:47:37.160101Z","end":"2026-08-22T13:47:38.388148Z","steps":["trace[338585778] 'agreement among raft nodes before linearized reading'  (duration: 1.227924265s)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.388154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.569772Z","time spent":"818.371851ms","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "}
{"level":"warn","ts":"2026-08-22T13:47:38.388169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.160078Z","time spent":"1.228088369s","remote":"127.0.0.1:45312","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":"warn","ts":"2026-08-22T13:47:38.388179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.907182ms","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":"warn","ts":"2026-08-22T13:47:38.388172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.86264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-22T13:47:38.38822Z","caller":"traceutil/trace.go:171","msg":"trace[1930337851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25182; }","duration":"638.974393ms","start":"2026-08-22T13:47:37.74923Z","end":"2026-08-22T13:47:38.388204Z","steps":["trace[1930337851] 'agreement among raft nodes before linearized reading'  (duration: 638.82488ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:38.388247Z","caller":"traceutil/trace.go:171","msg":"trace[1133038340] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:25182; }","duration":"215.976542ms","start":"2026-08-22T13:47:38.172249Z","end":"2026-08-22T13:47:38.388226Z","steps":["trace[1133038340] 'agreement among raft nodes before linearized reading'  (duration: 215.821809ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.388254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.749196Z","time spent":"639.050934ms","remote":"127.0.0.1:45398","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":"warn","ts":"2026-08-22T13:47:38.388423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.022843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-08-22T13:47:38.388425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.791175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-22T13:47:38.388449Z","caller":"traceutil/trace.go:171","msg":"trace[1311288777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25182; }","duration":"639.068775ms","start":"2026-08-22T13:47:37.749373Z","end":"2026-08-22T13:47:38.388442Z","steps":["trace[1311288777] 'agreement among raft nodes before linearized reading'  (duration: 638.938083ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:38.388465Z","caller":"traceutil/trace.go:171","msg":"trace[1698173593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25182; }","duration":"537.877426ms","start":"2026-08-22T13:47:37.850577Z","end":"2026-08-22T13:47:38.388455Z","steps":["trace[1698173593] 'agreement among raft nodes before linearized reading'  (duration: 537.720783ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:38.38847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.749348Z","time spent":"639.116335ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-22T13:47:38.388493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:37.850555Z","time spent":"537.932558ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-22T13:47:39.004129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.504474ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896140546 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25166 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:47:39.004415Z","caller":"traceutil/trace.go:171","msg":"trace[1865587583] transaction","detail":"{read_only:false; response_revision:25183; number_of_response:1; }","duration":"612.011623ms","start":"2026-08-22T13:47:38.392371Z","end":"2026-08-22T13:47:39.004382Z","steps":["trace[1865587583] 'process raft request'  (duration: 271.0662ms)","trace[1865587583] 'compare'  (duration: 339.75285ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:39.00453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.39236Z","time spent":"612.118555ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25166 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-08-22T13:47:39.004751Z","caller":"traceutil/trace.go:171","msg":"trace[619083131] transaction","detail":"{read_only:false; response_revision:25184; number_of_response:1; }","duration":"612.320599ms","start":"2026-08-22T13:47:38.392401Z","end":"2026-08-22T13:47:39.004722Z","steps":["trace[619083131] 'process raft request'  (duration: 611.904031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.004928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.392393Z","time spent":"612.438841ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25164 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-22T13:47:39.005073Z","caller":"traceutil/trace.go:171","msg":"trace[1829828359] transaction","detail":"{read_only:false; response_revision:25185; number_of_response:1; }","duration":"611.885331ms","start":"2026-08-22T13:47:38.393155Z","end":"2026-08-22T13:47:39.00504Z","steps":["trace[1829828359] 'process raft request'  (duration: 611.473523ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.005188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.393145Z","time spent":"611.978762ms","remote":"127.0.0.1:45398","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:25165 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-22T13:47:39.005305Z","caller":"traceutil/trace.go:171","msg":"trace[1531206525] transaction","detail":"{read_only:false; response_revision:25186; number_of_response:1; }","duration":"610.935123ms","start":"2026-08-22T13:47:38.394322Z","end":"2026-08-22T13:47:39.005257Z","steps":["trace[1531206525] 'process raft request'  (duration: 610.649348ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:39.005449Z","caller":"traceutil/trace.go:171","msg":"trace[1931998272] linearizableReadLoop","detail":"{readStateIndex:26003; appliedIndex:26001; }","duration":"612.625284ms","start":"2026-08-22T13:47:38.392807Z","end":"2026-08-22T13:47:39.005432Z","steps":["trace[1931998272] 'read index received'  (duration: 270.614732ms)","trace[1931998272] 'applied index is now lower than readState.Index'  (duration: 342.009042ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:39.00552Z","caller":"traceutil/trace.go:171","msg":"trace[460284537] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"606.747823ms","start":"2026-08-22T13:47:38.398753Z","end":"2026-08-22T13:47:39.0055Z","steps":["trace[460284537] 'process raft request'  (duration: 606.450667ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.005629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.816998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-08-22T13:47:39.005629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.398742Z","time spent":"606.824295ms","remote":"127.0.0.1:45398","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:25170 > 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-08-22T13:47:39.005674Z","caller":"traceutil/trace.go:171","msg":"trace[733544338] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:25187; }","duration":"612.87587ms","start":"2026-08-22T13:47:38.392787Z","end":"2026-08-22T13:47:39.005663Z","steps":["trace[733544338] 'agreement among raft nodes before linearized reading'  (duration: 612.764187ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.005682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.184649ms","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-08-22T13:47:39.005745Z","caller":"traceutil/trace.go:171","msg":"trace[1316944042] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25187; }","duration":"557.281902ms","start":"2026-08-22T13:47:38.448446Z","end":"2026-08-22T13:47:39.005728Z","steps":["trace[1316944042] 'agreement among raft nodes before linearized reading'  (duration: 557.187619ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.00576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.213675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:39.005788Z","caller":"traceutil/trace.go:171","msg":"trace[162102851] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25187; }","duration":"407.277136ms","start":"2026-08-22T13:47:38.598504Z","end":"2026-08-22T13:47:39.005781Z","steps":["trace[162102851] 'agreement among raft nodes before linearized reading'  (duration: 407.232675ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.005822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.59848Z","time spent":"407.337017ms","remote":"127.0.0.1:45124","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-08-22T13:47:39.005792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.448425Z","time spent":"557.358533ms","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-08-22T13:47:39.005705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.392778Z","time spent":"612.920651ms","remote":"127.0.0.1:45412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-08-22T13:47:39.006097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:38.394309Z","time spent":"611.082935ms","remote":"127.0.0.1:45398","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:25169 > 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-08-22T13:47:39.453127Z","caller":"traceutil/trace.go:171","msg":"trace[1212340696] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"361.811979ms","start":"2026-08-22T13:47:39.091291Z","end":"2026-08-22T13:47:39.453103Z","steps":["trace[1212340696] 'process raft request'  (duration: 350.642836ms)","trace[1212340696] 'compare'  (duration: 10.649373ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:39.453255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:39.091259Z","time spent":"361.929801ms","remote":"127.0.0.1:45398","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/kube-node-lease/instance\" mod_revision:25113 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-08-22T13:47:39.4733Z","caller":"traceutil/trace.go:171","msg":"trace[281859310] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"333.266507ms","start":"2026-08-22T13:47:39.139998Z","end":"2026-08-22T13:47:39.473264Z","steps":["trace[281859310] 'process raft request'  (duration: 333.042112ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.473566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:39.139972Z","time spent":"333.432989ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"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:25172 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:39.985204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.377457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:39.985317Z","caller":"traceutil/trace.go:171","msg":"trace[567903637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25189; }","duration":"385.54409ms","start":"2026-08-22T13:47:39.599747Z","end":"2026-08-22T13:47:39.985291Z","steps":["trace[567903637] 'range keys from in-memory index tree'  (duration: 385.281576ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.985375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:39.599722Z","time spent":"385.637793ms","remote":"127.0.0.1:45124","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-08-22T13:47:39.98546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.289134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-08-22T13:47:39.985543Z","caller":"traceutil/trace.go:171","msg":"trace[2084424663] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:25189; }","duration":"367.440927ms","start":"2026-08-22T13:47:39.618084Z","end":"2026-08-22T13:47:39.985525Z","steps":["trace[2084424663] 'count revisions from in-memory index tree'  (duration: 367.172802ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.985591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:39.618059Z","time spent":"367.521808ms","remote":"127.0.0.1:45312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":175,"response size":32,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"info","ts":"2026-08-22T13:47:39.98701Z","caller":"traceutil/trace.go:171","msg":"trace[390294024] linearizableReadLoop","detail":"{readStateIndex:26009; appliedIndex:26008; }","duration":"239.254606ms","start":"2026-08-22T13:47:39.747738Z","end":"2026-08-22T13:47:39.986992Z","steps":["trace[390294024] 'read index received'  (duration: 239.006861ms)","trace[390294024] 'applied index is now lower than readState.Index'  (duration: 246.375µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:39.987103Z","caller":"traceutil/trace.go:171","msg":"trace[1899541677] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"278.395512ms","start":"2026-08-22T13:47:39.70868Z","end":"2026-08-22T13:47:39.987075Z","steps":["trace[1899541677] 'process raft request'  (duration: 278.154957ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:39.987194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.45126ms","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-08-22T13:47:39.987234Z","caller":"traceutil/trace.go:171","msg":"trace[760117821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25190; }","duration":"239.48948ms","start":"2026-08-22T13:47:39.747731Z","end":"2026-08-22T13:47:39.98722Z","steps":["trace[760117821] 'agreement among raft nodes before linearized reading'  (duration: 239.323727ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.310125Z","caller":"traceutil/trace.go:171","msg":"trace[178361710] linearizableReadLoop","detail":"{readStateIndex:26113; appliedIndex:26112; }","duration":"228.558903ms","start":"2026-08-22T13:47:46.081531Z","end":"2026-08-22T13:47:46.31009Z","steps":["trace[178361710] 'read index received'  (duration: 173.80435ms)","trace[178361710] 'applied index is now lower than readState.Index'  (duration: 54.753033ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:46.310505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.96256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f8f333f-5e17-44f3-a247-4ee08b936872\" ","response":"range_response_count:1 size:3764"}
{"level":"info","ts":"2026-08-22T13:47:46.310591Z","caller":"traceutil/trace.go:171","msg":"trace[707035972] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f8f333f-5e17-44f3-a247-4ee08b936872; range_end:; response_count:1; response_revision:25292; }","duration":"229.095622ms","start":"2026-08-22T13:47:46.081472Z","end":"2026-08-22T13:47:46.310568Z","steps":["trace[707035972] 'agreement among raft nodes before linearized reading'  (duration: 228.822667ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.310882Z","caller":"traceutil/trace.go:171","msg":"trace[565914172] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"290.94956ms","start":"2026-08-22T13:47:46.019916Z","end":"2026-08-22T13:47:46.310866Z","steps":["trace[565914172] 'process raft request'  (duration: 235.467064ms)","trace[565914172] 'compare'  (duration: 54.036689ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:46.569425Z","caller":"traceutil/trace.go:171","msg":"trace[790211089] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"156.028621ms","start":"2026-08-22T13:47:46.413365Z","end":"2026-08-22T13:47:46.569394Z","steps":["trace[790211089] 'process raft request'  (duration: 83.605601ms)","trace[790211089] 'compare'  (duration: 71.44913ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:46.57266Z","caller":"traceutil/trace.go:171","msg":"trace[1511972341] linearizableReadLoop","detail":"{readStateIndex:26118; appliedIndex:26113; }","duration":"153.303509ms","start":"2026-08-22T13:47:46.419328Z","end":"2026-08-22T13:47:46.572631Z","steps":["trace[1511972341] 'read index received'  (duration: 77.599618ms)","trace[1511972341] 'applied index is now lower than readState.Index'  (duration: 75.702731ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:46.572853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.496403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-22T13:47:46.572887Z","caller":"traceutil/trace.go:171","msg":"trace[895949874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25297; }","duration":"153.590265ms","start":"2026-08-22T13:47:46.419288Z","end":"2026-08-22T13:47:46.572878Z","steps":["trace[895949874] 'agreement among raft nodes before linearized reading'  (duration: 153.452332ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.57339Z","caller":"traceutil/trace.go:171","msg":"trace[1533263841] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"157.55112ms","start":"2026-08-22T13:47:46.415829Z","end":"2026-08-22T13:47:46.57338Z","steps":["trace[1533263841] 'process raft request'  (duration: 156.509501ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.573543Z","caller":"traceutil/trace.go:171","msg":"trace[1640087532] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"157.57917ms","start":"2026-08-22T13:47:46.415956Z","end":"2026-08-22T13:47:46.573535Z","steps":["trace[1640087532] 'process raft request'  (duration: 156.552661ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.573614Z","caller":"traceutil/trace.go:171","msg":"trace[1278397291] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"156.315576ms","start":"2026-08-22T13:47:46.417292Z","end":"2026-08-22T13:47:46.573608Z","steps":["trace[1278397291] 'process raft request'  (duration: 155.251516ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.573684Z","caller":"traceutil/trace.go:171","msg":"trace[511266579] transaction","detail":"{read_only:false; response_revision:25297; number_of_response:1; }","duration":"156.328007ms","start":"2026-08-22T13:47:46.417349Z","end":"2026-08-22T13:47:46.573677Z","steps":["trace[511266579] 'process raft request'  (duration: 155.249556ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:46.901201Z","caller":"traceutil/trace.go:171","msg":"trace[1679845008] linearizableReadLoop","detail":"{readStateIndex:26119; appliedIndex:26118; }","duration":"312.708445ms","start":"2026-08-22T13:47:46.588466Z","end":"2026-08-22T13:47:46.901175Z","steps":["trace[1679845008] 'read index received'  (duration: 312.516621ms)","trace[1679845008] 'applied index is now lower than readState.Index'  (duration: 190.394µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:46.90137Z","caller":"traceutil/trace.go:171","msg":"trace[614293648] transaction","detail":"{read_only:false; response_revision:25298; number_of_response:1; }","duration":"323.103622ms","start":"2026-08-22T13:47:46.578251Z","end":"2026-08-22T13:47:46.901355Z","steps":["trace[614293648] 'process raft request'  (duration: 322.764356ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:46.901493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:46.578233Z","time spent":"323.172703ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25226 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-22T13:47:46.901494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.403581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:521"}
{"level":"info","ts":"2026-08-22T13:47:46.901548Z","caller":"traceutil/trace.go:171","msg":"trace[1475393763] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:25298; }","duration":"268.491273ms","start":"2026-08-22T13:47:46.633043Z","end":"2026-08-22T13:47:46.901535Z","steps":["trace[1475393763] 'agreement among raft nodes before linearized reading'  (duration: 268.35368ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:46.902207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.726174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:46.902284Z","caller":"traceutil/trace.go:171","msg":"trace[1913634617] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25298; }","duration":"313.866206ms","start":"2026-08-22T13:47:46.588403Z","end":"2026-08-22T13:47:46.902269Z","steps":["trace[1913634617] 'agreement among raft nodes before linearized reading'  (duration: 313.748934ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:46.902324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:46.58838Z","time spent":"313.934208ms","remote":"127.0.0.1:54896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "}
{"level":"warn","ts":"2026-08-22T13:47:46.903021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.280547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-22T13:47:46.903069Z","caller":"traceutil/trace.go:171","msg":"trace[1341741416] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25298; }","duration":"102.639975ms","start":"2026-08-22T13:47:46.800409Z","end":"2026-08-22T13:47:46.903049Z","steps":["trace[1341741416] 'agreement among raft nodes before linearized reading'  (duration: 102.290187ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:46.903138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.118888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-22T13:47:46.903184Z","caller":"traceutil/trace.go:171","msg":"trace[1091159913] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25298; }","duration":"171.19756ms","start":"2026-08-22T13:47:46.731974Z","end":"2026-08-22T13:47:46.903171Z","steps":["trace[1091159913] 'agreement among raft nodes before linearized reading'  (duration: 171.091118ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.156729Z","caller":"traceutil/trace.go:171","msg":"trace[424067249] linearizableReadLoop","detail":"{readStateIndex:26122; appliedIndex:26120; }","duration":"116.297624ms","start":"2026-08-22T13:47:47.040397Z","end":"2026-08-22T13:47:47.156694Z","steps":["trace[424067249] 'read index received'  (duration: 114.668664ms)","trace[424067249] 'applied index is now lower than readState.Index'  (duration: 1.62738ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:47.156832Z","caller":"traceutil/trace.go:171","msg":"trace[1204322603] transaction","detail":"{read_only:false; response_revision:25300; number_of_response:1; }","duration":"125.698413ms","start":"2026-08-22T13:47:47.031097Z","end":"2026-08-22T13:47:47.156796Z","steps":["trace[1204322603] 'process raft request'  (duration: 123.952871ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.156865Z","caller":"traceutil/trace.go:171","msg":"trace[693130315] transaction","detail":"{read_only:false; response_revision:25301; number_of_response:1; }","duration":"116.818374ms","start":"2026-08-22T13:47:47.040023Z","end":"2026-08-22T13:47:47.156842Z","steps":["trace[693130315] 'process raft request'  (duration: 116.58427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.157082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.628422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"}
{"level":"warn","ts":"2026-08-22T13:47:47.157136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.717907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-22T13:47:47.157159Z","caller":"traceutil/trace.go:171","msg":"trace[2037021637] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25301; }","duration":"115.739493ms","start":"2026-08-22T13:47:47.041394Z","end":"2026-08-22T13:47:47.157133Z","steps":["trace[2037021637] 'agreement among raft nodes before linearized reading'  (duration: 115.522759ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.157135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.701801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.182\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-08-22T13:47:47.157181Z","caller":"traceutil/trace.go:171","msg":"trace[1019892827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25301; }","duration":"111.832279ms","start":"2026-08-22T13:47:47.045336Z","end":"2026-08-22T13:47:47.157168Z","steps":["trace[1019892827] 'agreement among raft nodes before linearized reading'  (duration: 111.697597ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.157159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.415762ms","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-08-22T13:47:47.157232Z","caller":"traceutil/trace.go:171","msg":"trace[2025954760] range","detail":"{range_begin:/registry/masterleases/199.204.45.182; range_end:; response_count:1; response_revision:25301; }","duration":"116.865945ms","start":"2026-08-22T13:47:47.040345Z","end":"2026-08-22T13:47:47.157211Z","steps":["trace[2025954760] 'agreement among raft nodes before linearized reading'  (duration: 116.528469ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.157272Z","caller":"traceutil/trace.go:171","msg":"trace[2126394511] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25301; }","duration":"110.622725ms","start":"2026-08-22T13:47:47.046621Z","end":"2026-08-22T13:47:47.157244Z","steps":["trace[2126394511] 'agreement among raft nodes before linearized reading'  (duration: 110.297919ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.157356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.131525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-22T13:47:47.157401Z","caller":"traceutil/trace.go:171","msg":"trace[26730496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25301; }","duration":"112.205126ms","start":"2026-08-22T13:47:47.045185Z","end":"2026-08-22T13:47:47.15739Z","steps":["trace[26730496] 'agreement among raft nodes before linearized reading'  (duration: 112.026833ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.430359Z","caller":"traceutil/trace.go:171","msg":"trace[1917178771] linearizableReadLoop","detail":"{readStateIndex:26126; appliedIndex:26122; }","duration":"266.914692ms","start":"2026-08-22T13:47:47.163418Z","end":"2026-08-22T13:47:47.430333Z","steps":["trace[1917178771] 'read index received'  (duration: 13.658719ms)","trace[1917178771] 'applied index is now lower than readState.Index'  (duration: 253.255073ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:47.430487Z","caller":"traceutil/trace.go:171","msg":"trace[965059840] transaction","detail":"{read_only:false; response_revision:25304; number_of_response:1; }","duration":"267.440743ms","start":"2026-08-22T13:47:47.163031Z","end":"2026-08-22T13:47:47.430472Z","steps":["trace[965059840] 'process raft request'  (duration: 267.255389ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.430495Z","caller":"traceutil/trace.go:171","msg":"trace[1321346617] transaction","detail":"{read_only:false; response_revision:25303; number_of_response:1; }","duration":"267.608517ms","start":"2026-08-22T13:47:47.162852Z","end":"2026-08-22T13:47:47.430461Z","steps":["trace[1321346617] 'process raft request'  (duration: 267.389092ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.430637Z","caller":"traceutil/trace.go:171","msg":"trace[1321773646] transaction","detail":"{read_only:false; response_revision:25302; number_of_response:1; }","duration":"267.747609ms","start":"2026-08-22T13:47:47.162835Z","end":"2026-08-22T13:47:47.430583Z","steps":["trace[1321773646] 'process raft request'  (duration: 267.204799ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.430784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.3443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"}
{"level":"info","ts":"2026-08-22T13:47:47.430835Z","caller":"traceutil/trace.go:171","msg":"trace[1407931692] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:25304; }","duration":"267.440292ms","start":"2026-08-22T13:47:47.16338Z","end":"2026-08-22T13:47:47.430821Z","steps":["trace[1407931692] 'agreement among raft nodes before linearized reading'  (duration: 267.214858ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:47.447334Z","caller":"traceutil/trace.go:171","msg":"trace[768753198] transaction","detail":"{read_only:false; response_revision:25305; number_of_response:1; }","duration":"269.109094ms","start":"2026-08-22T13:47:47.17821Z","end":"2026-08-22T13:47:47.447319Z","steps":["trace[768753198] 'process raft request'  (duration: 268.929431ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.447589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.662897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-08-22T13:47:47.447679Z","caller":"traceutil/trace.go:171","msg":"trace[1585431410] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25305; }","duration":"257.83819ms","start":"2026-08-22T13:47:47.189824Z","end":"2026-08-22T13:47:47.447662Z","steps":["trace[1585431410] 'agreement among raft nodes before linearized reading'  (duration: 257.544554ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:47.447724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.032704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f8f333f-5e17-44f3-a247-4ee08b936872\" ","response":"range_response_count:1 size:3764"}
{"level":"info","ts":"2026-08-22T13:47:47.447838Z","caller":"traceutil/trace.go:171","msg":"trace[1676939206] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f8f333f-5e17-44f3-a247-4ee08b936872; range_end:; response_count:1; response_revision:25305; }","duration":"132.202528ms","start":"2026-08-22T13:47:47.315608Z","end":"2026-08-22T13:47:47.447811Z","steps":["trace[1676939206] 'agreement among raft nodes before linearized reading'  (duration: 131.77002ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:49.469238Z","caller":"traceutil/trace.go:171","msg":"trace[1414146620] linearizableReadLoop","detail":"{readStateIndex:26143; appliedIndex:26141; }","duration":"281.929028ms","start":"2026-08-22T13:47:49.187279Z","end":"2026-08-22T13:47:49.469208Z","steps":["trace[1414146620] 'read index received'  (duration: 281.662564ms)","trace[1414146620] 'applied index is now lower than readState.Index'  (duration: 265.244µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:47:49.469399Z","caller":"traceutil/trace.go:171","msg":"trace[2000335422] transaction","detail":"{read_only:false; response_revision:25320; number_of_response:1; }","duration":"305.975097ms","start":"2026-08-22T13:47:49.163416Z","end":"2026-08-22T13:47:49.469391Z","steps":["trace[2000335422] 'process raft request'  (duration: 305.551799ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:49.469532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:49.16337Z","time spent":"306.058729ms","remote":"127.0.0.1:45398","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:25301 > 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-08-22T13:47:49.469801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.964473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:47:49.469832Z","caller":"traceutil/trace.go:171","msg":"trace[176609352] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:25321; }","duration":"225.045415ms","start":"2026-08-22T13:47:49.244779Z","end":"2026-08-22T13:47:49.469824Z","steps":["trace[176609352] 'agreement among raft nodes before linearized reading'  (duration: 224.984834ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:49.469829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.499109ms","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-08-22T13:47:49.46999Z","caller":"traceutil/trace.go:171","msg":"trace[936991487] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25321; }","duration":"282.697932ms","start":"2026-08-22T13:47:49.187261Z","end":"2026-08-22T13:47:49.469959Z","steps":["trace[936991487] 'agreement among raft nodes before linearized reading'  (duration: 282.423367ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:49.470198Z","caller":"traceutil/trace.go:171","msg":"trace[2141715215] transaction","detail":"{read_only:false; response_revision:25321; number_of_response:1; }","duration":"306.69138ms","start":"2026-08-22T13:47:49.163453Z","end":"2026-08-22T13:47:49.470144Z","steps":["trace[2141715215] 'process raft request'  (duration: 305.712582ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:47:49.470494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:47:49.163417Z","time spent":"306.893694ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25300 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-22T13:47:54.583094Z","caller":"traceutil/trace.go:171","msg":"trace[422709192] linearizableReadLoop","detail":"{readStateIndex:26201; appliedIndex:26200; }","duration":"169.899375ms","start":"2026-08-22T13:47:54.413172Z","end":"2026-08-22T13:47:54.583072Z","steps":["trace[422709192] 'read index received'  (duration: 169.810724ms)","trace[422709192] 'applied index is now lower than readState.Index'  (duration: 87.051µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:47:54.583305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.114669ms","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-08-22T13:47:54.583279Z","caller":"traceutil/trace.go:171","msg":"trace[195947931] transaction","detail":"{read_only:false; response_revision:25377; number_of_response:1; }","duration":"231.839734ms","start":"2026-08-22T13:47:54.351338Z","end":"2026-08-22T13:47:54.583178Z","steps":["trace[195947931] 'process raft request'  (duration: 231.58893ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:54.583434Z","caller":"traceutil/trace.go:171","msg":"trace[1733604933] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25377; }","duration":"170.280613ms","start":"2026-08-22T13:47:54.413116Z","end":"2026-08-22T13:47:54.583397Z","steps":["trace[1733604933] 'agreement among raft nodes before linearized reading'  (duration: 170.065168ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:59.143883Z","caller":"traceutil/trace.go:171","msg":"trace[2085489278] transaction","detail":"{read_only:false; response_revision:25419; number_of_response:1; }","duration":"179.238643ms","start":"2026-08-22T13:47:58.964609Z","end":"2026-08-22T13:47:59.143848Z","steps":["trace[2085489278] 'process raft request'  (duration: 178.989488ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:47:59.145976Z","caller":"traceutil/trace.go:171","msg":"trace[1062801819] transaction","detail":"{read_only:false; response_revision:25420; number_of_response:1; }","duration":"108.68392ms","start":"2026-08-22T13:47:59.03726Z","end":"2026-08-22T13:47:59.145944Z","steps":["trace[1062801819] 'process raft request'  (duration: 108.510777ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:01.327491Z","caller":"traceutil/trace.go:171","msg":"trace[1022693073] transaction","detail":"{read_only:false; response_revision:25435; number_of_response:1; }","duration":"173.688827ms","start":"2026-08-22T13:48:01.153783Z","end":"2026-08-22T13:48:01.327472Z","steps":["trace[1022693073] 'process raft request'  (duration: 173.573505ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:17.788427Z","caller":"traceutil/trace.go:171","msg":"trace[1553852623] transaction","detail":"{read_only:false; response_revision:25566; number_of_response:1; }","duration":"201.486807ms","start":"2026-08-22T13:48:17.586904Z","end":"2026-08-22T13:48:17.78839Z","steps":["trace[1553852623] 'process raft request'  (duration: 126.075151ms)","trace[1553852623] 'compare'  (duration: 75.254733ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:17.788595Z","caller":"traceutil/trace.go:171","msg":"trace[1985411405] linearizableReadLoop","detail":"{readStateIndex:26396; appliedIndex:26394; }","duration":"147.58862ms","start":"2026-08-22T13:48:17.640968Z","end":"2026-08-22T13:48:17.788557Z","steps":["trace[1985411405] 'read index received'  (duration: 72.004401ms)","trace[1985411405] 'applied index is now lower than readState.Index'  (duration: 75.581919ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:17.788646Z","caller":"traceutil/trace.go:171","msg":"trace[792134104] transaction","detail":"{read_only:false; response_revision:25567; number_of_response:1; }","duration":"165.088043ms","start":"2026-08-22T13:48:17.623532Z","end":"2026-08-22T13:48:17.78862Z","steps":["trace[792134104] 'process raft request'  (duration: 164.823668ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:17.788912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.918277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1444"}
{"level":"info","ts":"2026-08-22T13:48:17.788944Z","caller":"traceutil/trace.go:171","msg":"trace[102167875] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25567; }","duration":"147.979488ms","start":"2026-08-22T13:48:17.640954Z","end":"2026-08-22T13:48:17.788933Z","steps":["trace[102167875] 'agreement among raft nodes before linearized reading'  (duration: 147.769144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:17.78896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.276962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:48:17.789034Z","caller":"traceutil/trace.go:171","msg":"trace[2103684488] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25567; }","duration":"139.411485ms","start":"2026-08-22T13:48:17.649598Z","end":"2026-08-22T13:48:17.789009Z","steps":["trace[2103684488] 'agreement among raft nodes before linearized reading'  (duration: 139.268912ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:17.789043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.952876ms","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-08-22T13:48:17.789091Z","caller":"traceutil/trace.go:171","msg":"trace[467345740] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25567; }","duration":"119.014377ms","start":"2026-08-22T13:48:17.670061Z","end":"2026-08-22T13:48:17.789076Z","steps":["trace[467345740] 'agreement among raft nodes before linearized reading'  (duration: 118.836923ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:17.78928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.396465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-22T13:48:17.789302Z","caller":"traceutil/trace.go:171","msg":"trace[2020473540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25567; }","duration":"128.439536ms","start":"2026-08-22T13:48:17.660856Z","end":"2026-08-22T13:48:17.789295Z","steps":["trace[2020473540] 'agreement among raft nodes before linearized reading'  (duration: 128.370505ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:17.789455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.156931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-22T13:48:17.789488Z","caller":"traceutil/trace.go:171","msg":"trace[2085965007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25567; }","duration":"128.238552ms","start":"2026-08-22T13:48:17.66124Z","end":"2026-08-22T13:48:17.789478Z","steps":["trace[2085965007] 'agreement among raft nodes before linearized reading'  (duration: 128.13597ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:18.014182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.541069ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896141490 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25554 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:48:18.014402Z","caller":"traceutil/trace.go:171","msg":"trace[1816164458] transaction","detail":"{read_only:false; response_revision:25568; number_of_response:1; }","duration":"209.724252ms","start":"2026-08-22T13:48:17.804585Z","end":"2026-08-22T13:48:18.014309Z","steps":["trace[1816164458] 'process raft request'  (duration: 91.943939ms)","trace[1816164458] 'compare'  (duration: 117.336025ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:18.033062Z","caller":"traceutil/trace.go:171","msg":"trace[1293439370] linearizableReadLoop","detail":"{readStateIndex:26398; appliedIndex:26396; }","duration":"224.860611ms","start":"2026-08-22T13:48:17.808175Z","end":"2026-08-22T13:48:18.033036Z","steps":["trace[1293439370] 'read index received'  (duration: 88.358052ms)","trace[1293439370] 'applied index is now lower than readState.Index'  (duration: 136.500319ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:18.033139Z","caller":"traceutil/trace.go:171","msg":"trace[1579991030] transaction","detail":"{read_only:false; response_revision:25570; number_of_response:1; }","duration":"219.740134ms","start":"2026-08-22T13:48:17.81338Z","end":"2026-08-22T13:48:18.03312Z","steps":["trace[1579991030] 'process raft request'  (duration: 219.51475ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.033353Z","caller":"traceutil/trace.go:171","msg":"trace[1107334546] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25570; }","duration":"100.091026ms","start":"2026-08-22T13:48:17.933245Z","end":"2026-08-22T13:48:18.033336Z","steps":["trace[1107334546] 'agreement among raft nodes before linearized reading'  (duration: 99.963613ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:18.03339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.203627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-08-22T13:48:18.03345Z","caller":"traceutil/trace.go:171","msg":"trace[1369124872] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25570; }","duration":"225.29824ms","start":"2026-08-22T13:48:17.808131Z","end":"2026-08-22T13:48:18.033429Z","steps":["trace[1369124872] 'agreement among raft nodes before linearized reading'  (duration: 225.089446ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.032967Z","caller":"traceutil/trace.go:171","msg":"trace[1695135898] transaction","detail":"{read_only:false; response_revision:25569; number_of_response:1; }","duration":"228.156655ms","start":"2026-08-22T13:48:17.804789Z","end":"2026-08-22T13:48:18.032946Z","steps":["trace[1695135898] 'process raft request'  (duration: 228.011412ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.935883Z","caller":"traceutil/trace.go:171","msg":"trace[1610786410] transaction","detail":"{read_only:false; response_revision:25573; number_of_response:1; }","duration":"142.36528ms","start":"2026-08-22T13:48:18.793494Z","end":"2026-08-22T13:48:18.935859Z","steps":["trace[1610786410] 'process raft request'  (duration: 142.278798ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.936063Z","caller":"traceutil/trace.go:171","msg":"trace[163681182] transaction","detail":"{read_only:false; response_revision:25572; number_of_response:1; }","duration":"147.903766ms","start":"2026-08-22T13:48:18.788149Z","end":"2026-08-22T13:48:18.936053Z","steps":["trace[163681182] 'process raft request'  (duration: 147.417987ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.936426Z","caller":"traceutil/trace.go:171","msg":"trace[911459362] transaction","detail":"{read_only:false; response_revision:25574; number_of_response:1; }","duration":"140.240321ms","start":"2026-08-22T13:48:18.796167Z","end":"2026-08-22T13:48:18.936407Z","steps":["trace[911459362] 'process raft request'  (duration: 139.647449ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.937057Z","caller":"traceutil/trace.go:171","msg":"trace[1793035552] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"138.798004ms","start":"2026-08-22T13:48:18.79821Z","end":"2026-08-22T13:48:18.937008Z","steps":["trace[1793035552] 'process raft request'  (duration: 138.133451ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.937Z","caller":"traceutil/trace.go:171","msg":"trace[454463420] linearizableReadLoop","detail":"{readStateIndex:26404; appliedIndex:26400; }","duration":"126.02719ms","start":"2026-08-22T13:48:18.810958Z","end":"2026-08-22T13:48:18.936985Z","steps":["trace[454463420] 'read index received'  (duration: 124.652193ms)","trace[454463420] 'applied index is now lower than readState.Index'  (duration: 1.374097ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:18.937228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.44909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:48:18.937315Z","caller":"traceutil/trace.go:171","msg":"trace[911165145] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:25575; }","duration":"156.594322ms","start":"2026-08-22T13:48:18.780695Z","end":"2026-08-22T13:48:18.937289Z","steps":["trace[911165145] 'agreement among raft nodes before linearized reading'  (duration: 156.439429ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:18.988571Z","caller":"traceutil/trace.go:171","msg":"trace[617780552] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"173.841811ms","start":"2026-08-22T13:48:18.814705Z","end":"2026-08-22T13:48:18.988547Z","steps":["trace[617780552] 'process raft request'  (duration: 173.438033ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:19.921688Z","caller":"traceutil/trace.go:171","msg":"trace[1920117908] transaction","detail":"{read_only:false; response_revision:25580; number_of_response:1; }","duration":"126.839965ms","start":"2026-08-22T13:48:19.79482Z","end":"2026-08-22T13:48:19.92166Z","steps":["trace[1920117908] 'process raft request'  (duration: 126.600621ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:19.92342Z","caller":"traceutil/trace.go:171","msg":"trace[1343989298] transaction","detail":"{read_only:false; response_revision:25581; number_of_response:1; }","duration":"127.596151ms","start":"2026-08-22T13:48:19.795789Z","end":"2026-08-22T13:48:19.923385Z","steps":["trace[1343989298] 'process raft request'  (duration: 127.433178ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:20.281283Z","caller":"traceutil/trace.go:171","msg":"trace[499196414] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"210.248463ms","start":"2026-08-22T13:48:20.070998Z","end":"2026-08-22T13:48:20.281246Z","steps":["trace[499196414] 'process raft request'  (duration: 210.117431ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:20.281281Z","caller":"traceutil/trace.go:171","msg":"trace[1949846596] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"210.795425ms","start":"2026-08-22T13:48:20.07043Z","end":"2026-08-22T13:48:20.281225Z","steps":["trace[1949846596] 'process raft request'  (duration: 210.488018ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:20.483743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.037895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-22T13:48:20.48389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.891356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:48:20.483914Z","caller":"traceutil/trace.go:171","msg":"trace[1401594555] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25585; }","duration":"121.263149ms","start":"2026-08-22T13:48:20.362621Z","end":"2026-08-22T13:48:20.483884Z","steps":["trace[1401594555] 'range keys from in-memory index tree'  (duration: 120.944913ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:20.483958Z","caller":"traceutil/trace.go:171","msg":"trace[1871269062] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:25585; }","duration":"106.974847ms","start":"2026-08-22T13:48:20.376962Z","end":"2026-08-22T13:48:20.483937Z","steps":["trace[1871269062] 'count revisions from in-memory index tree'  (duration: 106.804343ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:21.251777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.94302ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896141548 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25573 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:48:21.252035Z","caller":"traceutil/trace.go:171","msg":"trace[1122436254] linearizableReadLoop","detail":"{readStateIndex:26420; appliedIndex:26417; }","duration":"256.75292ms","start":"2026-08-22T13:48:20.99526Z","end":"2026-08-22T13:48:21.252013Z","steps":["trace[1122436254] 'read index received'  (duration: 121.371732ms)","trace[1122436254] 'applied index is now lower than readState.Index'  (duration: 135.375988ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:21.25227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.007624ms","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-08-22T13:48:21.252309Z","caller":"traceutil/trace.go:171","msg":"trace[1888358309] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25591; }","duration":"257.096296ms","start":"2026-08-22T13:48:20.995203Z","end":"2026-08-22T13:48:21.252299Z","steps":["trace[1888358309] 'agreement among raft nodes before linearized reading'  (duration: 256.899492ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:21.252678Z","caller":"traceutil/trace.go:171","msg":"trace[71985660] transaction","detail":"{read_only:false; response_revision:25589; number_of_response:1; }","duration":"309.969772ms","start":"2026-08-22T13:48:20.942694Z","end":"2026-08-22T13:48:21.252663Z","steps":["trace[71985660] 'process raft request'  (duration: 174.014073ms)","trace[71985660] 'compare'  (duration: 134.152745ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:21.252755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:48:20.942635Z","time spent":"310.081224ms","remote":"127.0.0.1:45398","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:25573 > 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-08-22T13:48:21.252921Z","caller":"traceutil/trace.go:171","msg":"trace[1336227087] transaction","detail":"{read_only:false; response_revision:25590; number_of_response:1; }","duration":"307.815301ms","start":"2026-08-22T13:48:20.945094Z","end":"2026-08-22T13:48:21.252909Z","steps":["trace[1336227087] 'process raft request'  (duration: 306.802712ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:21.252984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:48:20.945085Z","time spent":"307.867611ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25572 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-22T13:48:21.253132Z","caller":"traceutil/trace.go:171","msg":"trace[5453549] transaction","detail":"{read_only:false; response_revision:25591; number_of_response:1; }","duration":"300.912751ms","start":"2026-08-22T13:48:20.952208Z","end":"2026-08-22T13:48:21.253121Z","steps":["trace[5453549] 'process raft request'  (duration: 299.750218ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:21.253192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:48:20.952187Z","time spent":"300.976402ms","remote":"127.0.0.1:45398","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/capi-system/controller-leader-election-capi\" mod_revision:25575 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-22T13:48:21.417943Z","caller":"traceutil/trace.go:171","msg":"trace[1815453601] transaction","detail":"{read_only:false; response_revision:25592; number_of_response:1; }","duration":"158.428367ms","start":"2026-08-22T13:48:21.259491Z","end":"2026-08-22T13:48:21.41792Z","steps":["trace[1815453601] 'process raft request'  (duration: 136.353486ms)","trace[1815453601] 'compare'  (duration: 21.849506ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:21.82515Z","caller":"traceutil/trace.go:171","msg":"trace[700536334] linearizableReadLoop","detail":"{readStateIndex:26424; appliedIndex:26422; }","duration":"122.729047ms","start":"2026-08-22T13:48:21.702402Z","end":"2026-08-22T13:48:21.825131Z","steps":["trace[700536334] 'read index received'  (duration: 44.903655ms)","trace[700536334] 'applied index is now lower than readState.Index'  (duration: 77.824562ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:21.825279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.86632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-22T13:48:21.825315Z","caller":"traceutil/trace.go:171","msg":"trace[49400300] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:25595; }","duration":"122.958571ms","start":"2026-08-22T13:48:21.702347Z","end":"2026-08-22T13:48:21.825305Z","steps":["trace[49400300] 'agreement among raft nodes before linearized reading'  (duration: 122.859239ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:21.8256Z","caller":"traceutil/trace.go:171","msg":"trace[2013621691] transaction","detail":"{read_only:false; response_revision:25595; number_of_response:1; }","duration":"135.397368ms","start":"2026-08-22T13:48:21.690195Z","end":"2026-08-22T13:48:21.825592Z","steps":["trace[2013621691] 'process raft request'  (duration: 134.834607ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:27.153546Z","caller":"traceutil/trace.go:171","msg":"trace[273023168] linearizableReadLoop","detail":"{readStateIndex:26460; appliedIndex:26459; }","duration":"111.240398ms","start":"2026-08-22T13:48:27.042259Z","end":"2026-08-22T13:48:27.153499Z","steps":["trace[273023168] 'read index received'  (duration: 110.861541ms)","trace[273023168] 'applied index is now lower than readState.Index'  (duration: 377.597µs)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:27.153601Z","caller":"traceutil/trace.go:171","msg":"trace[1049447887] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"126.326616ms","start":"2026-08-22T13:48:27.02724Z","end":"2026-08-22T13:48:27.153567Z","steps":["trace[1049447887] 'process raft request'  (duration: 126.076551ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:27.153772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.485654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.182\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-08-22T13:48:27.153818Z","caller":"traceutil/trace.go:171","msg":"trace[2073126722] range","detail":"{range_begin:/registry/masterleases/199.204.45.182; range_end:; response_count:1; response_revision:25630; }","duration":"111.606585ms","start":"2026-08-22T13:48:27.042197Z","end":"2026-08-22T13:48:27.153804Z","steps":["trace[2073126722] 'agreement among raft nodes before linearized reading'  (duration: 111.421942ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:27.693624Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006765.wal"}
{"level":"info","ts":"2026-08-22T13:48:32.619338Z","caller":"traceutil/trace.go:171","msg":"trace[295933872] linearizableReadLoop","detail":"{readStateIndex:26506; appliedIndex:26505; }","duration":"118.758341ms","start":"2026-08-22T13:48:32.500548Z","end":"2026-08-22T13:48:32.619306Z","steps":["trace[295933872] 'read index received'  (duration: 47.130646ms)","trace[295933872] 'applied index is now lower than readState.Index'  (duration: 71.626045ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:32.620035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.481135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-08-22T13:48:32.620137Z","caller":"traceutil/trace.go:171","msg":"trace[308737324] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:25674; }","duration":"119.604058ms","start":"2026-08-22T13:48:32.50048Z","end":"2026-08-22T13:48:32.620084Z","steps":["trace[308737324] 'agreement among raft nodes before linearized reading'  (duration: 118.898795ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:33.069079Z","caller":"traceutil/trace.go:171","msg":"trace[2114246633] transaction","detail":"{read_only:false; response_revision:25675; number_of_response:1; }","duration":"151.283371ms","start":"2026-08-22T13:48:32.91777Z","end":"2026-08-22T13:48:33.069054Z","steps":["trace[2114246633] 'process raft request'  (duration: 151.097268ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:33.423983Z","caller":"traceutil/trace.go:171","msg":"trace[1657660564] transaction","detail":"{read_only:false; response_revision:25677; number_of_response:1; }","duration":"127.265643ms","start":"2026-08-22T13:48:33.296682Z","end":"2026-08-22T13:48:33.423947Z","steps":["trace[1657660564] 'process raft request'  (duration: 59.415481ms)","trace[1657660564] 'compare'  (duration: 67.426024ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:33.424486Z","caller":"traceutil/trace.go:171","msg":"trace[98540621] transaction","detail":"{read_only:false; response_revision:25678; number_of_response:1; }","duration":"125.05812ms","start":"2026-08-22T13:48:33.299382Z","end":"2026-08-22T13:48:33.42444Z","steps":["trace[98540621] 'process raft request'  (duration: 124.471799ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:33.424691Z","caller":"traceutil/trace.go:171","msg":"trace[2134141652] transaction","detail":"{read_only:false; response_revision:25679; number_of_response:1; }","duration":"124.196385ms","start":"2026-08-22T13:48:33.300432Z","end":"2026-08-22T13:48:33.424628Z","steps":["trace[2134141652] 'process raft request'  (duration: 123.976171ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:33.424816Z","caller":"traceutil/trace.go:171","msg":"trace[789063171] linearizableReadLoop","detail":"{readStateIndex:26510; appliedIndex:26508; }","duration":"125.163203ms","start":"2026-08-22T13:48:33.299624Z","end":"2026-08-22T13:48:33.424787Z","steps":["trace[789063171] 'read index received'  (duration: 56.548427ms)","trace[789063171] 'applied index is now lower than readState.Index'  (duration: 68.612686ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:33.425028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.381708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1985"}
{"level":"info","ts":"2026-08-22T13:48:33.425068Z","caller":"traceutil/trace.go:171","msg":"trace[189534939] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:25679; }","duration":"125.466379ms","start":"2026-08-22T13:48:33.299587Z","end":"2026-08-22T13:48:33.425053Z","steps":["trace[189534939] 'agreement among raft nodes before linearized reading'  (duration: 125.264084ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:34.044828Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22649}
{"level":"info","ts":"2026-08-22T13:48:34.196923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22649,"took":"148.251723ms","hash":3690765106,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":37429248,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-08-22T13:48:34.197014Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3690765106,"revision":22649,"compact-revision":19986}
{"level":"info","ts":"2026-08-22T13:48:37.442209Z","caller":"traceutil/trace.go:171","msg":"trace[389707773] transaction","detail":"{read_only:false; response_revision:25717; number_of_response:1; }","duration":"193.827701ms","start":"2026-08-22T13:48:37.248343Z","end":"2026-08-22T13:48:37.44217Z","steps":["trace[389707773] 'process raft request'  (duration: 193.519035ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:37.649014Z","caller":"traceutil/trace.go:171","msg":"trace[1349257079] transaction","detail":"{read_only:false; response_revision:25721; number_of_response:1; }","duration":"114.624192ms","start":"2026-08-22T13:48:37.53434Z","end":"2026-08-22T13:48:37.648965Z","steps":["trace[1349257079] 'process raft request'  (duration: 113.530812ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:43.238136Z","caller":"traceutil/trace.go:171","msg":"trace[339843007] transaction","detail":"{read_only:false; response_revision:25759; number_of_response:1; }","duration":"131.071975ms","start":"2026-08-22T13:48:43.10704Z","end":"2026-08-22T13:48:43.238112Z","steps":["trace[339843007] 'process raft request'  (duration: 130.926352ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:43.484199Z","caller":"traceutil/trace.go:171","msg":"trace[695922296] transaction","detail":"{read_only:false; response_revision:25760; number_of_response:1; }","duration":"296.27025ms","start":"2026-08-22T13:48:43.187887Z","end":"2026-08-22T13:48:43.484157Z","steps":["trace[695922296] 'process raft request'  (duration: 287.703787ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:43.719238Z","caller":"traceutil/trace.go:171","msg":"trace[29793307] linearizableReadLoop","detail":"{readStateIndex:26599; appliedIndex:26596; }","duration":"193.624297ms","start":"2026-08-22T13:48:43.525585Z","end":"2026-08-22T13:48:43.71921Z","steps":["trace[29793307] 'read index received'  (duration: 33.635211ms)","trace[29793307] 'applied index is now lower than readState.Index'  (duration: 159.982216ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:43.71927Z","caller":"traceutil/trace.go:171","msg":"trace[779469792] transaction","detail":"{read_only:false; response_revision:25763; number_of_response:1; }","duration":"227.057274ms","start":"2026-08-22T13:48:43.492181Z","end":"2026-08-22T13:48:43.719238Z","steps":["trace[779469792] 'process raft request'  (duration: 143.645875ms)","trace[779469792] 'compare'  (duration: 83.155024ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:43.719326Z","caller":"traceutil/trace.go:171","msg":"trace[1094984683] transaction","detail":"{read_only:false; response_revision:25764; number_of_response:1; }","duration":"206.369519ms","start":"2026-08-22T13:48:43.512925Z","end":"2026-08-22T13:48:43.719295Z","steps":["trace[1094984683] 'process raft request'  (duration: 206.215426ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:43.719529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.916993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"}
{"level":"info","ts":"2026-08-22T13:48:43.719578Z","caller":"traceutil/trace.go:171","msg":"trace[130103093] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:25764; }","duration":"194.033855ms","start":"2026-08-22T13:48:43.525529Z","end":"2026-08-22T13:48:43.719563Z","steps":["trace[130103093] 'agreement among raft nodes before linearized reading'  (duration: 193.848542ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:44.049587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.19422ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896141935 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25752 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:48:44.049782Z","caller":"traceutil/trace.go:171","msg":"trace[1500960312] linearizableReadLoop","detail":"{readStateIndex:26601; appliedIndex:26599; }","duration":"206.282597ms","start":"2026-08-22T13:48:43.843478Z","end":"2026-08-22T13:48:44.049761Z","steps":["trace[1500960312] 'read index received'  (duration: 174.273418ms)","trace[1500960312] 'applied index is now lower than readState.Index'  (duration: 32.007289ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:44.049862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.391109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-22T13:48:44.049899Z","caller":"traceutil/trace.go:171","msg":"trace[1187579035] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:25766; }","duration":"206.475651ms","start":"2026-08-22T13:48:43.84341Z","end":"2026-08-22T13:48:44.049885Z","steps":["trace[1187579035] 'agreement among raft nodes before linearized reading'  (duration: 206.41173ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:44.049899Z","caller":"traceutil/trace.go:171","msg":"trace[2041703411] transaction","detail":"{read_only:false; response_revision:25766; number_of_response:1; }","duration":"324.774844ms","start":"2026-08-22T13:48:43.725094Z","end":"2026-08-22T13:48:44.049869Z","steps":["trace[2041703411] 'process raft request'  (duration: 324.608901ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:44.049988Z","caller":"traceutil/trace.go:171","msg":"trace[1551535911] transaction","detail":"{read_only:false; response_revision:25765; number_of_response:1; }","duration":"325.438857ms","start":"2026-08-22T13:48:43.724515Z","end":"2026-08-22T13:48:44.049954Z","steps":["trace[1551535911] 'process raft request'  (duration: 101.786658ms)","trace[1551535911] 'compare'  (duration: 223.051738ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:44.050063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:48:43.725077Z","time spent":"324.900166ms","remote":"127.0.0.1:45398","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:25751 > 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-08-22T13:48:44.050129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T13:48:43.724497Z","time spent":"325.557649ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25752 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-22T13:48:44.149123Z","caller":"traceutil/trace.go:171","msg":"trace[1495780001] transaction","detail":"{read_only:false; response_revision:25767; number_of_response:1; }","duration":"238.283367ms","start":"2026-08-22T13:48:43.910804Z","end":"2026-08-22T13:48:44.149088Z","steps":["trace[1495780001] 'process raft request'  (duration: 238.055293ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:44.285261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.123411ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402372896141938 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25754 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-22T13:48:44.285523Z","caller":"traceutil/trace.go:171","msg":"trace[908234429] transaction","detail":"{read_only:false; response_revision:25768; number_of_response:1; }","duration":"278.90218ms","start":"2026-08-22T13:48:44.00658Z","end":"2026-08-22T13:48:44.285482Z","steps":["trace[908234429] 'process raft request'  (duration: 142.436832ms)","trace[908234429] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/messaging-topology-operator-leader-election; req_size:552; } (duration: 135.629212ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:44.285625Z","caller":"traceutil/trace.go:171","msg":"trace[1474041001] transaction","detail":"{read_only:false; response_revision:25769; number_of_response:1; }","duration":"270.826376ms","start":"2026-08-22T13:48:44.014769Z","end":"2026-08-22T13:48:44.285595Z","steps":["trace[1474041001] 'process raft request'  (duration: 270.613432ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:48:44.507256Z","caller":"traceutil/trace.go:171","msg":"trace[1987604553] linearizableReadLoop","detail":"{readStateIndex:26605; appliedIndex:26604; }","duration":"204.068456ms","start":"2026-08-22T13:48:44.303158Z","end":"2026-08-22T13:48:44.507226Z","steps":["trace[1987604553] 'read index received'  (duration: 123.281978ms)","trace[1987604553] 'applied index is now lower than readState.Index'  (duration: 80.785368ms)"],"step_count":2}
{"level":"info","ts":"2026-08-22T13:48:44.50734Z","caller":"traceutil/trace.go:171","msg":"trace[404744690] transaction","detail":"{read_only:false; response_revision:25770; number_of_response:1; }","duration":"225.884421ms","start":"2026-08-22T13:48:44.281415Z","end":"2026-08-22T13:48:44.507299Z","steps":["trace[404744690] 'process raft request'  (duration: 145.041342ms)","trace[404744690] 'compare'  (duration: 80.616914ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-22T13:48:44.507531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.357231ms","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-08-22T13:48:44.507578Z","caller":"traceutil/trace.go:171","msg":"trace[1425311261] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25770; }","duration":"204.465093ms","start":"2026-08-22T13:48:44.303098Z","end":"2026-08-22T13:48:44.507563Z","steps":["trace[1425311261] 'agreement among raft nodes before linearized reading'  (duration: 204.28923ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-22T13:48:44.507835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.061216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-22T13:48:44.507915Z","caller":"traceutil/trace.go:171","msg":"trace[310230653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25770; }","duration":"100.194039ms","start":"2026-08-22T13:48:44.407702Z","end":"2026-08-22T13:48:44.507896Z","steps":["trace[310230653] 'agreement among raft nodes before linearized reading'  (duration: 99.838552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-22T13:53:34.052947Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25691}
{"level":"info","ts":"2026-08-22T13:53:34.201639Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25691,"took":"144.456972ms","hash":2409186787,"current-db-size-bytes":59260928,"current-db-size":"59 MB","current-db-size-in-use-bytes":35880960,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-08-22T13:53:34.201714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2409186787,"revision":25691,"compact-revision":22649}
{"level":"info","ts":"2026-08-22T13:54:43.492678Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-22T13:54:43.497826Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-22T13:54:43.497893Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-08-22T13:58:34.059185Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28576}
{"level":"info","ts":"2026-08-22T13:58:34.197863Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28576,"took":"134.013002ms","hash":1367702950,"current-db-size-bytes":59260928,"current-db-size":"59 MB","current-db-size-in-use-bytes":31002624,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-22T13:58:34.198088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1367702950,"revision":28576,"compact-revision":25691}
{"level":"info","ts":"2026-08-22T14:03:34.065911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30802}
{"level":"info","ts":"2026-08-22T14:03:34.182301Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30802,"took":"112.812432ms","hash":1107567054,"current-db-size-bytes":59260928,"current-db-size":"59 MB","current-db-size-in-use-bytes":31719424,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-22T14:03:34.182367Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1107567054,"revision":30802,"compact-revision":28576}
{"level":"info","ts":"2026-08-22T14:08:34.072923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33131}
{"level":"info","ts":"2026-08-22T14:08:34.22878Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33131,"took":"152.407338ms","hash":1963236065,"current-db-size-bytes":60301312,"current-db-size":"60 MB","current-db-size-in-use-bytes":31875072,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-22T14:08:34.228849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1963236065,"revision":33131,"compact-revision":30802}
{"level":"info","ts":"2026-08-22T14:13:34.080462Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35457}
{"level":"info","ts":"2026-08-22T14:13:34.235324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35457,"took":"146.309003ms","hash":722361849,"current-db-size-bytes":60768256,"current-db-size":"61 MB","current-db-size-in-use-bytes":32337920,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-22T14:13:34.235402Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":722361849,"revision":35457,"compact-revision":33131}
{"level":"info","ts":"2026-08-22T14:15:55.130496Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-22T14:15:55.139254Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-08-22T14:15:55.139492Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-08-22T14:18:34.087157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37688}
{"level":"info","ts":"2026-08-22T14:18:34.207504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37688,"took":"116.982643ms","hash":178327652,"current-db-size-bytes":60768256,"current-db-size":"61 MB","current-db-size-in-use-bytes":32301056,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-22T14:18:34.207576Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":178327652,"revision":37688,"compact-revision":35457}