{"level":"warn","ts":"2026-03-05T09:46:15.189678Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-05T09:46:15.189781Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.139:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.139:2380","--initial-cluster=instance=https://199.19.213.139:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.139:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.139: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-03-05T09:46:15.189858Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-05T09:46:15.189871Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.139:2380"]}
{"level":"info","ts":"2026-03-05T09:46:15.189893Z","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-03-05T09:46:15.19053Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"]}
{"level":"info","ts":"2026-03-05T09:46:15.190606Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.139:2380"],"listen-peer-urls":["https://199.19.213.139:2380"],"advertise-client-urls":["https://199.19.213.139:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.139: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-03-05T09:46:15.195335Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.516815ms"}
{"level":"info","ts":"2026-03-05T09:46:15.202487Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb257ce137899862","cluster-id":"9913588efaa998c1"}
{"level":"info","ts":"2026-03-05T09:46:15.202589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-05T09:46:15.202617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became follower at term 0"}
{"level":"info","ts":"2026-03-05T09:46:15.202637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb257ce137899862 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-05T09:46:15.202654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became follower at term 1"}
{"level":"info","ts":"2026-03-05T09:46:15.202694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=(14638243470578915426)"}
{"level":"warn","ts":"2026-03-05T09:46:15.209112Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-05T09:46:15.211114Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-05T09:46:15.213021Z","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-03-05T09:46:15.216383Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb257ce137899862","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-05T09:46:15.216521Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb257ce137899862","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-05T09:46:15.216768Z","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-03-05T09:46:15.216935Z","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-03-05T09:46:15.217038Z","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-03-05T09:46:15.219086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=(14638243470578915426)"}
{"level":"info","ts":"2026-03-05T09:46:15.219466Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9913588efaa998c1","local-member-id":"cb257ce137899862","added-peer-id":"cb257ce137899862","added-peer-peer-urls":["https://199.19.213.139:2380"]}
{"level":"info","ts":"2026-03-05T09:46:15.223374Z","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-03-05T09:46:15.223435Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.139:2380"}
{"level":"info","ts":"2026-03-05T09:46:15.223464Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.139:2380"}
{"level":"info","ts":"2026-03-05T09:46:15.223949Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb257ce137899862","initial-advertise-peer-urls":["https://199.19.213.139:2380"],"listen-peer-urls":["https://199.19.213.139:2380"],"advertise-client-urls":["https://199.19.213.139:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-05T09:46:15.223952Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-05T09:46:15.303209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-05T09:46:15.303266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-05T09:46:15.303303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 received MsgPreVoteResp from cb257ce137899862 at term 1"}
{"level":"info","ts":"2026-03-05T09:46:15.303324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became candidate at term 2"}
{"level":"info","ts":"2026-03-05T09:46:15.303336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 received MsgVoteResp from cb257ce137899862 at term 2"}
{"level":"info","ts":"2026-03-05T09:46:15.303352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became leader at term 2"}
{"level":"info","ts":"2026-03-05T09:46:15.303371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb257ce137899862 elected leader cb257ce137899862 at term 2"}
{"level":"info","ts":"2026-03-05T09:46:15.304303Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T09:46:15.304488Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb257ce137899862","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.139:2379]}","request-path":"/0/members/cb257ce137899862/attributes","cluster-id":"9913588efaa998c1","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-05T09:46:15.30454Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T09:46:15.304673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T09:46:15.304951Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-05T09:46:15.305061Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-05T09:46:15.305992Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9913588efaa998c1","local-member-id":"cb257ce137899862","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T09:46:15.306117Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T09:46:15.306155Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T09:46:15.307955Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-05T09:46:15.308526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.139:2379"}
{"level":"info","ts":"2026-03-05T09:47:03.82473Z","caller":"traceutil/trace.go:171","msg":"trace[125710822] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"103.702767ms","start":"2026-03-05T09:47:03.720985Z","end":"2026-03-05T09:47:03.824687Z","steps":["trace[125710822] 'process raft request'  (duration: 81.592332ms)","trace[125710822] 'compare'  (duration: 21.983762ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:47:04.527512Z","caller":"traceutil/trace.go:171","msg":"trace[17610297] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"270.715933ms","start":"2026-03-05T09:47:04.256779Z","end":"2026-03-05T09:47:04.527495Z","steps":["trace[17610297] 'process raft request'  (duration: 270.565ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:47:27.50752Z","caller":"traceutil/trace.go:171","msg":"trace[2073796649] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"113.111489ms","start":"2026-03-05T09:47:27.394388Z","end":"2026-03-05T09:47:27.507499Z","steps":["trace[2073796649] 'process raft request'  (duration: 112.967756ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:47:27.836716Z","caller":"traceutil/trace.go:171","msg":"trace[649200589] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"321.405161ms","start":"2026-03-05T09:47:27.515277Z","end":"2026-03-05T09:47:27.836682Z","steps":["trace[649200589] 'process raft request'  (duration: 321.185936ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:47:27.837409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:47:27.515246Z","time spent":"321.558935ms","remote":"127.0.0.1:42512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3297,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" mod_revision:557 > success:<request_put:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" value_size:3216 >> failure:<request_range:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" > >"}
{"level":"warn","ts":"2026-03-05T09:48:31.293588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.212442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T09:48:31.293737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.225504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4a7df33b-e13e-4d98-8b51-de732c37209d\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-03-05T09:48:31.293797Z","caller":"traceutil/trace.go:171","msg":"trace[1939719944] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1677; }","duration":"169.486558ms","start":"2026-03-05T09:48:31.124282Z","end":"2026-03-05T09:48:31.293769Z","steps":["trace[1939719944] 'count revisions from in-memory index tree'  (duration: 169.117401ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:48:31.293797Z","caller":"traceutil/trace.go:171","msg":"trace[1725430837] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4a7df33b-e13e-4d98-8b51-de732c37209d; range_end:; response_count:1; response_revision:1677; }","duration":"149.314876ms","start":"2026-03-05T09:48:31.144465Z","end":"2026-03-05T09:48:31.29378Z","steps":["trace[1725430837] 'range keys from in-memory index tree'  (duration: 149.02044ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:48:31.726663Z","caller":"traceutil/trace.go:171","msg":"trace[384458122] transaction","detail":"{read_only:false; response_revision:1678; number_of_response:1; }","duration":"277.680503ms","start":"2026-03-05T09:48:31.448957Z","end":"2026-03-05T09:48:31.726637Z","steps":["trace[384458122] 'process raft request'  (duration: 277.512719ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:48:31.728108Z","caller":"traceutil/trace.go:171","msg":"trace[850534365] linearizableReadLoop","detail":"{readStateIndex:1747; appliedIndex:1744; }","duration":"103.196385ms","start":"2026-03-05T09:48:31.624878Z","end":"2026-03-05T09:48:31.728074Z","steps":["trace[850534365] 'read index received'  (duration: 101.700034ms)","trace[850534365] 'applied index is now lower than readState.Index'  (duration: 1.494371ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:48:31.728508Z","caller":"traceutil/trace.go:171","msg":"trace[483897846] transaction","detail":"{read_only:false; response_revision:1679; number_of_response:1; }","duration":"176.764156ms","start":"2026-03-05T09:48:31.551701Z","end":"2026-03-05T09:48:31.728465Z","steps":["trace[483897846] 'process raft request'  (duration: 176.165073ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:48:31.728658Z","caller":"traceutil/trace.go:171","msg":"trace[1027819075] transaction","detail":"{read_only:false; response_revision:1680; number_of_response:1; }","duration":"171.710018ms","start":"2026-03-05T09:48:31.556831Z","end":"2026-03-05T09:48:31.728541Z","steps":["trace[1027819075] 'process raft request'  (duration: 171.191586ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:48:31.729121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.215448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-05T09:48:31.72967Z","caller":"traceutil/trace.go:171","msg":"trace[1134157729] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1680; }","duration":"104.81241ms","start":"2026-03-05T09:48:31.624832Z","end":"2026-03-05T09:48:31.729644Z","steps":["trace[1134157729] 'agreement among raft nodes before linearized reading'  (duration: 104.160157ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:48:51.369112Z","caller":"traceutil/trace.go:171","msg":"trace[181911255] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"305.234034ms","start":"2026-03-05T09:48:51.063854Z","end":"2026-03-05T09:48:51.369088Z","steps":["trace[181911255] 'process raft request'  (duration: 305.094601ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:48:51.369264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:48:51.063822Z","time spent":"305.369497ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1790 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-03-05T09:49:11.175057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.968628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-05T09:49:11.175229Z","caller":"traceutil/trace.go:171","msg":"trace[1842759457] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1934; }","duration":"180.175462ms","start":"2026-03-05T09:49:10.995033Z","end":"2026-03-05T09:49:11.175208Z","steps":["trace[1842759457] 'range keys from in-memory index tree'  (duration: 179.730652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:11.175314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.299325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T09:49:11.17542Z","caller":"traceutil/trace.go:171","msg":"trace[1121081896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1934; }","duration":"198.453259ms","start":"2026-03-05T09:49:10.976946Z","end":"2026-03-05T09:49:11.1754Z","steps":["trace[1121081896] 'range keys from in-memory index tree'  (duration: 198.216244ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:28.286972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.961722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10980511178723635861 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2004 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T09:49:28.287162Z","caller":"traceutil/trace.go:171","msg":"trace[1428322683] linearizableReadLoop","detail":"{readStateIndex:2093; appliedIndex:2091; }","duration":"202.81183ms","start":"2026-03-05T09:49:28.084329Z","end":"2026-03-05T09:49:28.287141Z","steps":["trace[1428322683] 'read index received'  (duration: 82.731µs)","trace[1428322683] 'applied index is now lower than readState.Index'  (duration: 202.727609ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:49:28.287217Z","caller":"traceutil/trace.go:171","msg":"trace[1139735994] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"345.995017ms","start":"2026-03-05T09:49:27.941176Z","end":"2026-03-05T09:49:28.287171Z","steps":["trace[1139735994] 'process raft request'  (duration: 345.900445ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:49:28.287253Z","caller":"traceutil/trace.go:171","msg":"trace[1640970606] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"347.865347ms","start":"2026-03-05T09:49:27.939331Z","end":"2026-03-05T09:49:28.287196Z","steps":["trace[1640970606] 'process raft request'  (duration: 120.434295ms)","trace[1640970606] 'compare'  (duration: 226.800829ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T09:49:28.28842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:27.941162Z","time spent":"346.136721ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2005 > 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-03-05T09:49:28.287299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.946034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T09:49:28.288667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:27.939313Z","time spent":"349.257477ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2004 > 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-03-05T09:49:28.288743Z","caller":"traceutil/trace.go:171","msg":"trace[1304633474] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:2014; }","duration":"204.398294ms","start":"2026-03-05T09:49:28.084275Z","end":"2026-03-05T09:49:28.288673Z","steps":["trace[1304633474] 'agreement among raft nodes before linearized reading'  (duration: 202.942623ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:28.725744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.91488ms","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-03-05T09:49:28.725852Z","caller":"traceutil/trace.go:171","msg":"trace[803011648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2015; }","duration":"117.068583ms","start":"2026-03-05T09:49:28.608757Z","end":"2026-03-05T09:49:28.725825Z","steps":["trace[803011648] 'range keys from in-memory index tree'  (duration: 116.684856ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:28.726005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.70868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-05T09:49:28.726077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.680468ms","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-03-05T09:49:28.72609Z","caller":"traceutil/trace.go:171","msg":"trace[1609117135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2015; }","duration":"112.833573ms","start":"2026-03-05T09:49:28.613237Z","end":"2026-03-05T09:49:28.72607Z","steps":["trace[1609117135] 'range keys from in-memory index tree'  (duration: 112.510446ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:49:28.726155Z","caller":"traceutil/trace.go:171","msg":"trace[339530415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2015; }","duration":"143.80011ms","start":"2026-03-05T09:49:28.582334Z","end":"2026-03-05T09:49:28.726134Z","steps":["trace[339530415] 'range keys from in-memory index tree'  (duration: 143.422822ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:28.726406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.579384ms","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-03-05T09:49:28.726547Z","caller":"traceutil/trace.go:171","msg":"trace[829350613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2015; }","duration":"101.752348ms","start":"2026-03-05T09:49:28.624755Z","end":"2026-03-05T09:49:28.726507Z","steps":["trace[829350613] 'range keys from in-memory index tree'  (duration: 101.013812ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:29.08692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:28.726879Z","time spent":"360.037546ms","remote":"127.0.0.1:42066","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-05T09:49:29.156401Z","caller":"traceutil/trace.go:171","msg":"trace[318215806] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"426.75746ms","start":"2026-03-05T09:49:28.729625Z","end":"2026-03-05T09:49:29.156382Z","steps":["trace[318215806] 'process raft request'  (duration: 419.232831ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:29.156513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:28.729601Z","time spent":"426.851322ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2008 > 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-03-05T09:49:29.156664Z","caller":"traceutil/trace.go:171","msg":"trace[926742188] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"426.946334ms","start":"2026-03-05T09:49:28.729694Z","end":"2026-03-05T09:49:29.15664Z","steps":["trace[926742188] 'process raft request'  (duration: 426.656467ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:49:29.156724Z","caller":"traceutil/trace.go:171","msg":"trace[1590966721] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"426.515946ms","start":"2026-03-05T09:49:28.73019Z","end":"2026-03-05T09:49:29.156705Z","steps":["trace[1590966721] 'process raft request'  (duration: 426.371923ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:29.156797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:28.729669Z","time spent":"427.054807ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2010 > 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-03-05T09:49:29.156826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:28.730169Z","time spent":"426.603278ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2009 > 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-03-05T09:49:29.156952Z","caller":"traceutil/trace.go:171","msg":"trace[2046806158] linearizableReadLoop","detail":"{readStateIndex:2099; appliedIndex:2094; }","duration":"317.597237ms","start":"2026-03-05T09:49:28.839344Z","end":"2026-03-05T09:49:29.156941Z","steps":["trace[2046806158] 'read index received'  (duration: 247.518231ms)","trace[2046806158] 'applied index is now lower than readState.Index'  (duration: 70.078076ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:49:29.156958Z","caller":"traceutil/trace.go:171","msg":"trace[1353879614] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"252.954606ms","start":"2026-03-05T09:49:28.903995Z","end":"2026-03-05T09:49:29.15695Z","steps":["trace[1353879614] 'process raft request'  (duration: 252.69036ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:29.15704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.707729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T09:49:29.156943Z","caller":"traceutil/trace.go:171","msg":"trace[652342874] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"426.402533ms","start":"2026-03-05T09:49:28.730524Z","end":"2026-03-05T09:49:29.156927Z","steps":["trace[652342874] 'process raft request'  (duration: 426.121037ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:49:29.157077Z","caller":"traceutil/trace.go:171","msg":"trace[374667124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2021; }","duration":"317.801861ms","start":"2026-03-05T09:49:28.839266Z","end":"2026-03-05T09:49:29.157068Z","steps":["trace[374667124] 'agreement among raft nodes before linearized reading'  (duration: 317.74763ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:29.157106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:28.83924Z","time spent":"317.859862ms","remote":"127.0.0.1:42044","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-03-05T09:49:29.157131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T09:49:28.730514Z","time spent":"426.575597ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2007 > 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-03-05T09:49:29.157188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.401437ms","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-03-05T09:49:29.157227Z","caller":"traceutil/trace.go:171","msg":"trace[1551387437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2021; }","duration":"280.466218ms","start":"2026-03-05T09:49:28.876738Z","end":"2026-03-05T09:49:29.157204Z","steps":["trace[1551387437] 'agreement among raft nodes before linearized reading'  (duration: 280.371136ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:49:29.157272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.997167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T09:49:29.157375Z","caller":"traceutil/trace.go:171","msg":"trace[43901537] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2021; }","duration":"113.172431ms","start":"2026-03-05T09:49:29.044188Z","end":"2026-03-05T09:49:29.15736Z","steps":["trace[43901537] 'agreement among raft nodes before linearized reading'  (duration: 113.029598ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:50:55.791687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.224793ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10980511178723637304 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2624 > 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:16"}
{"level":"info","ts":"2026-03-05T09:50:55.791806Z","caller":"traceutil/trace.go:171","msg":"trace[1450773010] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"152.672938ms","start":"2026-03-05T09:50:55.639113Z","end":"2026-03-05T09:50:55.791786Z","steps":["trace[1450773010] 'process raft request'  (duration: 24.238471ms)","trace[1450773010] 'compare'  (duration: 127.892795ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:50:55.810553Z","caller":"traceutil/trace.go:171","msg":"trace[831151589] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"170.924003ms","start":"2026-03-05T09:50:55.639606Z","end":"2026-03-05T09:50:55.81053Z","steps":["trace[831151589] 'process raft request'  (duration: 170.746869ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:50:55.810896Z","caller":"traceutil/trace.go:171","msg":"trace[870277380] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"171.066006ms","start":"2026-03-05T09:50:55.639805Z","end":"2026-03-05T09:50:55.810871Z","steps":["trace[870277380] 'process raft request'  (duration: 170.688588ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:50:55.811237Z","caller":"traceutil/trace.go:171","msg":"trace[1433347436] transaction","detail":"{read_only:false; response_revision:2634; number_of_response:1; }","duration":"170.639167ms","start":"2026-03-05T09:50:55.640572Z","end":"2026-03-05T09:50:55.811211Z","steps":["trace[1433347436] 'process raft request'  (duration: 170.185776ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:54:36.523172Z","caller":"traceutil/trace.go:171","msg":"trace[454620961] transaction","detail":"{read_only:false; response_revision:4376; number_of_response:1; }","duration":"103.948026ms","start":"2026-03-05T09:54:36.419202Z","end":"2026-03-05T09:54:36.52315Z","steps":["trace[454620961] 'process raft request'  (duration: 103.799713ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:54:45.788483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.532205ms","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-03-05T09:54:45.788558Z","caller":"traceutil/trace.go:171","msg":"trace[224151554] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4680; }","duration":"109.629477ms","start":"2026-03-05T09:54:45.678913Z","end":"2026-03-05T09:54:45.788543Z","steps":["trace[224151554] 'count revisions from in-memory index tree'  (duration: 109.449552ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T09:54:45.788496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.050345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba89e93c-d07c-4561-b9d4-ca111d99a288\" ","response":"range_response_count:1 size:3718"}
{"level":"info","ts":"2026-03-05T09:54:45.78871Z","caller":"traceutil/trace.go:171","msg":"trace[397416793] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba89e93c-d07c-4561-b9d4-ca111d99a288; range_end:; response_count:1; response_revision:4680; }","duration":"127.32226ms","start":"2026-03-05T09:54:45.661364Z","end":"2026-03-05T09:54:45.788687Z","steps":["trace[397416793] 'range keys from in-memory index tree'  (duration: 126.880021ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T09:54:54.952139Z","caller":"traceutil/trace.go:171","msg":"trace[115269563] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"108.601865ms","start":"2026-03-05T09:54:54.843497Z","end":"2026-03-05T09:54:54.952099Z","steps":["trace[115269563] 'process raft request'  (duration: 91.863592ms)","trace[115269563] 'compare'  (duration: 16.545769ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:54:55.435763Z","caller":"traceutil/trace.go:171","msg":"trace[1731345117] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"134.561223ms","start":"2026-03-05T09:54:55.301173Z","end":"2026-03-05T09:54:55.435734Z","steps":["trace[1731345117] 'process raft request'  (duration: 106.331587ms)","trace[1731345117] 'compare'  (duration: 28.105463ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T09:56:15.60256Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2731}
{"level":"info","ts":"2026-03-05T09:56:15.654905Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2731,"took":"51.005705ms","hash":3905471699,"current-db-size-bytes":40833024,"current-db-size":"41 MB","current-db-size-in-use-bytes":30683136,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-05T09:56:15.654966Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3905471699,"revision":2731,"compact-revision":-1}
{"level":"info","ts":"2026-03-05T10:01:15.615905Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5678}
{"level":"info","ts":"2026-03-05T10:01:15.704042Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5678,"took":"86.376401ms","hash":1887753213,"current-db-size-bytes":40833024,"current-db-size":"41 MB","current-db-size-in-use-bytes":21540864,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-03-05T10:01:15.704192Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1887753213,"revision":5678,"compact-revision":2731}
{"level":"info","ts":"2026-03-05T10:01:40.767702Z","caller":"traceutil/trace.go:171","msg":"trace[1133550185] transaction","detail":"{read_only:false; response_revision:7835; number_of_response:1; }","duration":"139.67692ms","start":"2026-03-05T10:01:40.628Z","end":"2026-03-05T10:01:40.767677Z","steps":["trace[1133550185] 'process raft request'  (duration: 139.445576ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:01:41.15109Z","caller":"traceutil/trace.go:171","msg":"trace[2074606673] transaction","detail":"{read_only:false; response_revision:7839; number_of_response:1; }","duration":"112.30701ms","start":"2026-03-05T10:01:41.038757Z","end":"2026-03-05T10:01:41.151064Z","steps":["trace[2074606673] 'process raft request'  (duration: 102.270048ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:01:41.464827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.334101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T10:01:41.464934Z","caller":"traceutil/trace.go:171","msg":"trace[585992061] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7842; }","duration":"155.503735ms","start":"2026-03-05T10:01:41.309403Z","end":"2026-03-05T10:01:41.464907Z","steps":["trace[585992061] 'range keys from in-memory index tree'  (duration: 155.160338ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:02:11.203887Z","caller":"traceutil/trace.go:171","msg":"trace[1364101187] transaction","detail":"{read_only:false; response_revision:8041; number_of_response:1; }","duration":"104.771797ms","start":"2026-03-05T10:02:11.099085Z","end":"2026-03-05T10:02:11.203856Z","steps":["trace[1364101187] 'process raft request'  (duration: 91.259931ms)","trace[1364101187] 'compare'  (duration: 13.376533ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T10:02:22.617546Z","caller":"traceutil/trace.go:171","msg":"trace[1483087185] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8135; }","duration":"240.393302ms","start":"2026-03-05T10:02:22.377129Z","end":"2026-03-05T10:02:22.617523Z","steps":["trace[1483087185] 'process raft request'  (duration: 151.500472ms)","trace[1483087185] 'compare'  (duration: 88.576654ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T10:02:22.634705Z","caller":"traceutil/trace.go:171","msg":"trace[1985593907] transaction","detail":"{read_only:false; response_revision:8136; number_of_response:1; }","duration":"256.404824ms","start":"2026-03-05T10:02:22.378264Z","end":"2026-03-05T10:02:22.634669Z","steps":["trace[1985593907] 'process raft request'  (duration: 256.127188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:02:22.634716Z","caller":"traceutil/trace.go:171","msg":"trace[1169395520] transaction","detail":"{read_only:false; response_revision:8137; number_of_response:1; }","duration":"251.349016ms","start":"2026-03-05T10:02:22.383304Z","end":"2026-03-05T10:02:22.634653Z","steps":["trace[1169395520] 'process raft request'  (duration: 251.283484ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:02:23.210491Z","caller":"traceutil/trace.go:171","msg":"trace[201489271] transaction","detail":"{read_only:false; response_revision:8139; number_of_response:1; }","duration":"113.521873ms","start":"2026-03-05T10:02:23.096896Z","end":"2026-03-05T10:02:23.210418Z","steps":["trace[201489271] 'process raft request'  (duration: 113.280528ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.884044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.239044ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10980511178723651577 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-m9khx.1899e9c0ed42a201\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-m9khx.1899e9c0ed42a201\" value_size:654 lease:1757139141868875296 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-05T10:02:23.88436Z","caller":"traceutil/trace.go:171","msg":"trace[1143964059] transaction","detail":"{read_only:false; response_revision:8143; number_of_response:1; }","duration":"648.022143ms","start":"2026-03-05T10:02:23.236316Z","end":"2026-03-05T10:02:23.884338Z","steps":["trace[1143964059] 'process raft request'  (duration: 647.971362ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:02:23.884501Z","caller":"traceutil/trace.go:171","msg":"trace[1514756294] transaction","detail":"{read_only:false; response_revision:8141; number_of_response:1; }","duration":"704.875742ms","start":"2026-03-05T10:02:23.17959Z","end":"2026-03-05T10:02:23.884466Z","steps":["trace[1514756294] 'process raft request'  (duration: 704.559626ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:02:23.884544Z","caller":"traceutil/trace.go:171","msg":"trace[1938183378] linearizableReadLoop","detail":"{readStateIndex:8446; appliedIndex:8444; }","duration":"674.153159ms","start":"2026-03-05T10:02:23.21036Z","end":"2026-03-05T10:02:23.884513Z","steps":["trace[1938183378] 'read index received'  (duration: 422.355224ms)","trace[1938183378] 'applied index is now lower than readState.Index'  (duration: 251.794405ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T10:02:23.884574Z","caller":"traceutil/trace.go:171","msg":"trace[1477578837] transaction","detail":"{read_only:false; response_revision:8140; number_of_response:1; }","duration":"711.390161ms","start":"2026-03-05T10:02:23.173168Z","end":"2026-03-05T10:02:23.884558Z","steps":["trace[1477578837] 'process raft request'  (duration: 459.533055ms)","trace[1477578837] 'compare'  (duration: 251.010779ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T10:02:23.884454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.236299Z","time spent":"648.108794ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8119 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-05T10:02:23.884628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.17315Z","time spent":"711.452822ms","remote":"127.0.0.1:42094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-m9khx.1899e9c0ed42a201\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-m9khx.1899e9c0ed42a201\" value_size:654 lease:1757139141868875296 >> failure:<>"}
{"level":"info","ts":"2026-03-05T10:02:23.884619Z","caller":"traceutil/trace.go:171","msg":"trace[969895103] transaction","detail":"{read_only:false; response_revision:8142; number_of_response:1; }","duration":"669.9668ms","start":"2026-03-05T10:02:23.214601Z","end":"2026-03-05T10:02:23.884567Z","steps":["trace[969895103] 'process raft request'  (duration: 669.639833ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.8848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.552305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-m9khx\" ","response":"range_response_count:1 size:4650"}
{"level":"warn","ts":"2026-03-05T10:02:23.88484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.214582Z","time spent":"670.148413ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8118 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-05T10:02:23.88486Z","caller":"traceutil/trace.go:171","msg":"trace[1918098695] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-m9khx; range_end:; response_count:1; response_revision:8143; }","duration":"712.640537ms","start":"2026-03-05T10:02:23.172202Z","end":"2026-03-05T10:02:23.884843Z","steps":["trace[1918098695] 'agreement among raft nodes before linearized reading'  (duration: 712.404982ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.8849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.172186Z","time spent":"712.705818ms","remote":"127.0.0.1:42184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4674,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-m9khx\" "}
{"level":"warn","ts":"2026-03-05T10:02:23.88467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.17958Z","time spent":"705.005985ms","remote":"127.0.0.1:42240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8131 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"warn","ts":"2026-03-05T10:02:23.920224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.538518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"warn","ts":"2026-03-05T10:02:23.920275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.108026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T10:02:23.920339Z","caller":"traceutil/trace.go:171","msg":"trace[1603653064] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:8143; }","duration":"105.179717ms","start":"2026-03-05T10:02:23.815142Z","end":"2026-03-05T10:02:23.920322Z","steps":["trace[1603653064] 'agreement among raft nodes before linearized reading'  (duration: 105.060805ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.920242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.526983ms","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-03-05T10:02:23.920412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.266145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-03-05T10:02:23.920449Z","caller":"traceutil/trace.go:171","msg":"trace[785558373] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8143; }","duration":"622.321477ms","start":"2026-03-05T10:02:23.298121Z","end":"2026-03-05T10:02:23.920442Z","steps":["trace[785558373] 'agreement among raft nodes before linearized reading'  (duration: 622.242615ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.920474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.29811Z","time spent":"622.358977ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"info","ts":"2026-03-05T10:02:23.920294Z","caller":"traceutil/trace.go:171","msg":"trace[411280330] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8143; }","duration":"635.65655ms","start":"2026-03-05T10:02:23.284619Z","end":"2026-03-05T10:02:23.920275Z","steps":["trace[411280330] 'agreement among raft nodes before linearized reading'  (duration: 635.461066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.920497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.669142ms","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-03-05T10:02:23.920551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.284601Z","time spent":"635.920326ms","remote":"127.0.0.1:35422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5756,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "}
{"level":"info","ts":"2026-03-05T10:02:23.920587Z","caller":"traceutil/trace.go:171","msg":"trace[1715384400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8143; }","duration":"494.808465ms","start":"2026-03-05T10:02:23.425761Z","end":"2026-03-05T10:02:23.920569Z","steps":["trace[1715384400] 'agreement among raft nodes before linearized reading'  (duration: 494.544819ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.920632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.42574Z","time spent":"494.883327ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-05T10:02:23.920349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.167473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T10:02:23.920627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.120146ms","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-03-05T10:02:23.92058Z","caller":"traceutil/trace.go:171","msg":"trace[1294330377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8143; }","duration":"403.786819ms","start":"2026-03-05T10:02:23.516651Z","end":"2026-03-05T10:02:23.920437Z","steps":["trace[1294330377] 'agreement among raft nodes before linearized reading'  (duration: 403.437801ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:02:23.920765Z","caller":"traceutil/trace.go:171","msg":"trace[732092108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8143; }","duration":"467.30816ms","start":"2026-03-05T10:02:23.453425Z","end":"2026-03-05T10:02:23.920733Z","steps":["trace[732092108] 'agreement among raft nodes before linearized reading'  (duration: 467.006884ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.920842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.45341Z","time spent":"467.417142ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-05T10:02:23.920698Z","caller":"traceutil/trace.go:171","msg":"trace[555032985] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8143; }","duration":"574.52775ms","start":"2026-03-05T10:02:23.346146Z","end":"2026-03-05T10:02:23.920673Z","steps":["trace[555032985] 'agreement among raft nodes before linearized reading'  (duration: 574.172802ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.920806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.516628Z","time spent":"404.162606ms","remote":"127.0.0.1:42266","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-03-05T10:02:23.92091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.346135Z","time spent":"574.758575ms","remote":"127.0.0.1:47160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "}
{"level":"warn","ts":"2026-03-05T10:02:23.920624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.20779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-f2l57\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-05T10:02:23.921209Z","caller":"traceutil/trace.go:171","msg":"trace[812372839] range","detail":"{range_begin:/registry/pods/openstack/keepalived-f2l57; range_end:; response_count:1; response_revision:8143; }","duration":"170.839844ms","start":"2026-03-05T10:02:23.750353Z","end":"2026-03-05T10:02:23.921192Z","steps":["trace[812372839] 'agreement among raft nodes before linearized reading'  (duration: 169.902134ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.921249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.53019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-05T10:02:23.921323Z","caller":"traceutil/trace.go:171","msg":"trace[698872709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8143; }","duration":"401.625853ms","start":"2026-03-05T10:02:23.519678Z","end":"2026-03-05T10:02:23.921303Z","steps":["trace[698872709] 'agreement among raft nodes before linearized reading'  (duration: 401.399808ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:02:23.921383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:02:23.519666Z","time spent":"401.704554ms","remote":"127.0.0.1:42266","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-03-05T10:02:24.507714Z","caller":"traceutil/trace.go:171","msg":"trace[403084745] transaction","detail":"{read_only:false; response_revision:8152; number_of_response:1; }","duration":"100.031437ms","start":"2026-03-05T10:02:24.407659Z","end":"2026-03-05T10:02:24.50769Z","steps":["trace[403084745] 'process raft request'  (duration: 99.874853ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:05:38.495861Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cb257ce137899862","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-05T10:05:38.501353Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-05T10:05:38.501437Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-05T10:06:15.622528Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7588}
{"level":"info","ts":"2026-03-05T10:06:15.682149Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7588,"took":"57.733314ms","hash":671722684,"current-db-size-bytes":40833024,"current-db-size":"41 MB","current-db-size-in-use-bytes":26005504,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-05T10:06:15.682218Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":671722684,"revision":7588,"compact-revision":5678}
{"level":"info","ts":"2026-03-05T10:07:29.489279Z","caller":"traceutil/trace.go:171","msg":"trace[151120109] linearizableReadLoop","detail":"{readStateIndex:10999; appliedIndex:10998; }","duration":"168.473472ms","start":"2026-03-05T10:07:29.320776Z","end":"2026-03-05T10:07:29.489249Z","steps":["trace[151120109] 'read index received'  (duration: 67.704918ms)","trace[151120109] 'applied index is now lower than readState.Index'  (duration: 100.767474ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T10:07:29.48934Z","caller":"traceutil/trace.go:171","msg":"trace[237300321] transaction","detail":"{read_only:false; response_revision:10618; number_of_response:1; }","duration":"169.487572ms","start":"2026-03-05T10:07:29.319829Z","end":"2026-03-05T10:07:29.489317Z","steps":["trace[237300321] 'process raft request'  (duration: 144.191992ms)","trace[237300321] 'compare'  (duration: 25.033395ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T10:07:29.489409Z","caller":"traceutil/trace.go:171","msg":"trace[1552587619] transaction","detail":"{read_only:false; response_revision:10619; number_of_response:1; }","duration":"166.180252ms","start":"2026-03-05T10:07:29.323195Z","end":"2026-03-05T10:07:29.489375Z","steps":["trace[1552587619] 'process raft request'  (duration: 165.986148ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:07:29.489568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.628764ms","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-03-05T10:07:29.489613Z","caller":"traceutil/trace.go:171","msg":"trace[863839057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10619; }","duration":"167.718755ms","start":"2026-03-05T10:07:29.321883Z","end":"2026-03-05T10:07:29.489601Z","steps":["trace[863839057] 'agreement among raft nodes before linearized reading'  (duration: 167.526971ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:07:29.489783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.969102ms","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-03-05T10:07:29.489882Z","caller":"traceutil/trace.go:171","msg":"trace[1917469561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10619; }","duration":"169.112765ms","start":"2026-03-05T10:07:29.320749Z","end":"2026-03-05T10:07:29.489862Z","steps":["trace[1917469561] 'agreement among raft nodes before linearized reading'  (duration: 168.634585ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:07:29.704896Z","caller":"traceutil/trace.go:171","msg":"trace[526195265] transaction","detail":"{read_only:false; response_revision:10620; number_of_response:1; }","duration":"210.093931ms","start":"2026-03-05T10:07:29.494774Z","end":"2026-03-05T10:07:29.704867Z","steps":["trace[526195265] 'process raft request'  (duration: 209.933818ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:07:29.714307Z","caller":"traceutil/trace.go:171","msg":"trace[1205597613] transaction","detail":"{read_only:false; response_revision:10621; number_of_response:1; }","duration":"219.305958ms","start":"2026-03-05T10:07:29.494977Z","end":"2026-03-05T10:07:29.714283Z","steps":["trace[1205597613] 'process raft request'  (duration: 219.165255ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:11:15.62837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10026}
{"level":"info","ts":"2026-03-05T10:11:15.708207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10026,"took":"76.846986ms","hash":154571707,"current-db-size-bytes":40833024,"current-db-size":"41 MB","current-db-size-in-use-bytes":23461888,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-05T10:11:15.708271Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":154571707,"revision":10026,"compact-revision":7588}
{"level":"info","ts":"2026-03-05T10:13:24.746832Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000340e.wal"}
{"level":"info","ts":"2026-03-05T10:13:53.917152Z","caller":"traceutil/trace.go:171","msg":"trace[251739008] transaction","detail":"{read_only:false; response_revision:13011; number_of_response:1; }","duration":"155.577708ms","start":"2026-03-05T10:13:53.761529Z","end":"2026-03-05T10:13:53.917107Z","steps":["trace[251739008] 'process raft request'  (duration: 155.20326ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:13:53.922761Z","caller":"traceutil/trace.go:171","msg":"trace[1893804134] transaction","detail":"{read_only:false; response_revision:13013; number_of_response:1; }","duration":"157.551158ms","start":"2026-03-05T10:13:53.76519Z","end":"2026-03-05T10:13:53.922742Z","steps":["trace[1893804134] 'process raft request'  (duration: 157.524298ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:13:53.922839Z","caller":"traceutil/trace.go:171","msg":"trace[1353039533] transaction","detail":"{read_only:false; response_revision:13012; number_of_response:1; }","duration":"160.307187ms","start":"2026-03-05T10:13:53.762505Z","end":"2026-03-05T10:13:53.922812Z","steps":["trace[1353039533] 'process raft request'  (duration: 160.104693ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:14:12.163856Z","caller":"traceutil/trace.go:171","msg":"trace[1961305712] transaction","detail":"{read_only:false; response_revision:13106; number_of_response:1; }","duration":"158.158882ms","start":"2026-03-05T10:14:12.005666Z","end":"2026-03-05T10:14:12.163825Z","steps":["trace[1961305712] 'process raft request'  (duration: 157.985608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:14:12.276517Z","caller":"traceutil/trace.go:171","msg":"trace[1220591535] transaction","detail":"{read_only:false; response_revision:13107; number_of_response:1; }","duration":"268.604327ms","start":"2026-03-05T10:14:12.007877Z","end":"2026-03-05T10:14:12.276481Z","steps":["trace[1220591535] 'process raft request'  (duration: 240.233655ms)","trace[1220591535] 'compare'  (duration: 28.090987ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T10:14:20.623418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.480231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-hk2tq\" ","response":"range_response_count:1 size:12364"}
{"level":"info","ts":"2026-03-05T10:14:20.623593Z","caller":"traceutil/trace.go:171","msg":"trace[1830727847] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-hk2tq; range_end:; response_count:1; response_revision:13159; }","duration":"144.724187ms","start":"2026-03-05T10:14:20.478819Z","end":"2026-03-05T10:14:20.623543Z","steps":["trace[1830727847] 'range keys from in-memory index tree'  (duration: 144.205115ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:14:20.643452Z","caller":"traceutil/trace.go:171","msg":"trace[1689482510] transaction","detail":"{read_only:false; response_revision:13160; number_of_response:1; }","duration":"113.878359ms","start":"2026-03-05T10:14:20.529553Z","end":"2026-03-05T10:14:20.643432Z","steps":["trace[1689482510] 'process raft request'  (duration: 113.748246ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:14:20.827349Z","caller":"traceutil/trace.go:171","msg":"trace[828284058] linearizableReadLoop","detail":"{readStateIndex:13639; appliedIndex:13637; }","duration":"186.226328ms","start":"2026-03-05T10:14:20.641077Z","end":"2026-03-05T10:14:20.827303Z","steps":["trace[828284058] 'read index received'  (duration: 2.319719ms)","trace[828284058] 'applied index is now lower than readState.Index'  (duration: 183.905499ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T10:14:20.827396Z","caller":"traceutil/trace.go:171","msg":"trace[1150258118] transaction","detail":"{read_only:false; response_revision:13161; number_of_response:1; }","duration":"189.1629ms","start":"2026-03-05T10:14:20.638195Z","end":"2026-03-05T10:14:20.827358Z","steps":["trace[1150258118] 'process raft request'  (duration: 188.938206ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:14:20.827691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.569275ms","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:7"}
{"level":"info","ts":"2026-03-05T10:14:20.827764Z","caller":"traceutil/trace.go:171","msg":"trace[1673787210] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:13161; }","duration":"186.721348ms","start":"2026-03-05T10:14:20.641025Z","end":"2026-03-05T10:14:20.827747Z","steps":["trace[1673787210] 'agreement among raft nodes before linearized reading'  (duration: 186.429612ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:14:46.921102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.549203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T10:14:46.921166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.924749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T10:14:46.92124Z","caller":"traceutil/trace.go:171","msg":"trace[1178951029] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:13304; }","duration":"320.781278ms","start":"2026-03-05T10:14:46.600434Z","end":"2026-03-05T10:14:46.921216Z","steps":["trace[1178951029] 'count revisions from in-memory index tree'  (duration: 320.3893ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:14:46.921237Z","caller":"traceutil/trace.go:171","msg":"trace[1980493264] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:13304; }","duration":"391.041061ms","start":"2026-03-05T10:14:46.530174Z","end":"2026-03-05T10:14:46.921215Z","steps":["trace[1980493264] 'range keys from in-memory index tree'  (duration: 390.761185ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T10:14:46.921288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:14:46.530145Z","time spent":"391.132744ms","remote":"127.0.0.1:42474","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-03-05T10:14:46.921317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T10:14:46.600399Z","time spent":"320.878391ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "}
{"level":"info","ts":"2026-03-05T10:14:46.926018Z","caller":"traceutil/trace.go:171","msg":"trace[780910981] transaction","detail":"{read_only:false; response_revision:13305; number_of_response:1; }","duration":"182.634301ms","start":"2026-03-05T10:14:46.743354Z","end":"2026-03-05T10:14:46.925988Z","steps":["trace[780910981] 'process raft request'  (duration: 182.261033ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:16:15.635941Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11982}
{"level":"info","ts":"2026-03-05T10:16:15.716007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11982,"took":"76.953515ms","hash":1845089998,"current-db-size-bytes":40833024,"current-db-size":"41 MB","current-db-size-in-use-bytes":26480640,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-05T10:16:15.716189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1845089998,"revision":11982,"compact-revision":10026}
{"level":"info","ts":"2026-03-05T10:16:20.169611Z","caller":"traceutil/trace.go:171","msg":"trace[236508933] linearizableReadLoop","detail":"{readStateIndex:14798; appliedIndex:14797; }","duration":"108.888334ms","start":"2026-03-05T10:16:20.060702Z","end":"2026-03-05T10:16:20.169591Z","steps":["trace[236508933] 'read index received'  (duration: 108.70097ms)","trace[236508933] 'applied index is now lower than readState.Index'  (duration: 186.644µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T10:16:20.169761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.045078ms","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-03-05T10:16:20.170005Z","caller":"traceutil/trace.go:171","msg":"trace[1226296704] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14280; }","duration":"109.357644ms","start":"2026-03-05T10:16:20.060636Z","end":"2026-03-05T10:16:20.169994Z","steps":["trace[1226296704] 'agreement among raft nodes before linearized reading'  (duration: 109.066588ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:16:20.169728Z","caller":"traceutil/trace.go:171","msg":"trace[1627516880] transaction","detail":"{read_only:false; response_revision:14280; number_of_response:1; }","duration":"186.920512ms","start":"2026-03-05T10:16:19.982735Z","end":"2026-03-05T10:16:20.169656Z","steps":["trace[1627516880] 'process raft request'  (duration: 186.734848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T10:21:15.643726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14259}
{"level":"info","ts":"2026-03-05T10:21:15.744721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14259,"took":"96.915587ms","hash":4207944462,"current-db-size-bytes":41259008,"current-db-size":"41 MB","current-db-size-in-use-bytes":27324416,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-03-05T10:21:15.744791Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4207944462,"revision":14259,"compact-revision":11982}
{"level":"info","ts":"2026-03-05T10:26:15.653815Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16307}
{"level":"info","ts":"2026-03-05T10:26:15.754634Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16307,"took":"96.486316ms","hash":3501210385,"current-db-size-bytes":41259008,"current-db-size":"41 MB","current-db-size-in-use-bytes":23777280,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-05T10:26:15.75471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3501210385,"revision":16307,"compact-revision":14259}