{"level":"warn","ts":"2026-05-06T05:04:49.899752Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-06T05:04:49.899893Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.30: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.30:2380","--initial-cluster=instance=https://199.19.213.30:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.30:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.30:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-06T05:04:49.89999Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-06T05:04:49.899999Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.30:2380"]}
{"level":"info","ts":"2026-05-06T05:04:49.90002Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-06T05:04:49.900736Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"]}
{"level":"info","ts":"2026-05-06T05:04:49.900857Z","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.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.30:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-06T05:04:49.905009Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.858645ms"}
{"level":"info","ts":"2026-05-06T05:04:49.912409Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2b5783e11defe7e","cluster-id":"5210a9231a779bf0"}
{"level":"info","ts":"2026-05-06T05:04:49.912513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=()"}
{"level":"info","ts":"2026-05-06T05:04:49.912551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 0"}
{"level":"info","ts":"2026-05-06T05:04:49.912582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2b5783e11defe7e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-06T05:04:49.912605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 1"}
{"level":"info","ts":"2026-05-06T05:04:49.912659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"}
{"level":"warn","ts":"2026-05-06T05:04:49.925171Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-06T05:04:49.926781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-06T05:04:49.929323Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-06T05:04:49.933875Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2b5783e11defe7e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-06T05:04:49.9349Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2b5783e11defe7e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-06T05:04:49.935144Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-06T05:04:49.935292Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-06T05:04:49.935354Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-06T05:04:49.938245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"}
{"level":"info","ts":"2026-05-06T05:04:49.93857Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","added-peer-id":"e2b5783e11defe7e","added-peer-peer-urls":["https://199.19.213.30:2380"]}
{"level":"info","ts":"2026-05-06T05:04:49.939466Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-06T05:04:49.939524Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.30:2380"}
{"level":"info","ts":"2026-05-06T05:04:49.939573Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.30:2380"}
{"level":"info","ts":"2026-05-06T05:04:49.9398Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2b5783e11defe7e","initial-advertise-peer-urls":["https://199.19.213.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-06T05:04:49.939852Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-06T05:04:50.013531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e is starting a new election at term 1"}
{"level":"info","ts":"2026-05-06T05:04:50.013628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-06T05:04:50.013655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgPreVoteResp from e2b5783e11defe7e at term 1"}
{"level":"info","ts":"2026-05-06T05:04:50.01368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became candidate at term 2"}
{"level":"info","ts":"2026-05-06T05:04:50.013693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgVoteResp from e2b5783e11defe7e at term 2"}
{"level":"info","ts":"2026-05-06T05:04:50.01371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became leader at term 2"}
{"level":"info","ts":"2026-05-06T05:04:50.013732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2b5783e11defe7e elected leader e2b5783e11defe7e at term 2"}
{"level":"info","ts":"2026-05-06T05:04:50.014934Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2b5783e11defe7e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.30:2379]}","request-path":"/0/members/e2b5783e11defe7e/attributes","cluster-id":"5210a9231a779bf0","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-06T05:04:50.014969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-06T05:04:50.01506Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-06T05:04:50.015222Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-06T05:04:50.015341Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-06T05:04:50.015089Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T05:04:50.016361Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T05:04:50.016486Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T05:04:50.016533Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T05:04:50.01899Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-06T05:04:50.019491Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.30:2379"}
{"level":"info","ts":"2026-05-06T05:05:26.478555Z","caller":"traceutil/trace.go:171","msg":"trace[134182579] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"117.153506ms","start":"2026-05-06T05:05:26.361376Z","end":"2026-05-06T05:05:26.478529Z","steps":["trace[134182579] 'process raft request'  (duration: 116.93323ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:05:26.717281Z","caller":"traceutil/trace.go:171","msg":"trace[488124007] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"103.275238ms","start":"2026-05-06T05:05:26.613963Z","end":"2026-05-06T05:05:26.717238Z","steps":["trace[488124007] 'process raft request'  (duration: 44.197266ms)","trace[488124007] 'compare'  (duration: 58.890626ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:05:26.726806Z","caller":"traceutil/trace.go:171","msg":"trace[286258253] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"110.421789ms","start":"2026-05-06T05:05:26.616338Z","end":"2026-05-06T05:05:26.72676Z","steps":["trace[286258253] 'process raft request'  (duration: 105.115983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:05:27.222706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.734118ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958346461 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-06T05:05:27.222857Z","caller":"traceutil/trace.go:171","msg":"trace[642977237] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"218.067284ms","start":"2026-05-06T05:05:27.004771Z","end":"2026-05-06T05:05:27.222838Z","steps":["trace[642977237] 'read index received'  (duration: 36.371997ms)","trace[642977237] 'applied index is now lower than readState.Index'  (duration: 181.693707ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:05:27.222985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.205578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:05:27.222926Z","caller":"traceutil/trace.go:171","msg":"trace[1956821860] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"431.838742ms","start":"2026-05-06T05:05:26.791027Z","end":"2026-05-06T05:05:27.222865Z","steps":["trace[1956821860] 'process raft request'  (duration: 250.085923ms)","trace[1956821860] 'compare'  (duration: 180.493272ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:05:27.22302Z","caller":"traceutil/trace.go:171","msg":"trace[923861852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"218.29052ms","start":"2026-05-06T05:05:27.00472Z","end":"2026-05-06T05:05:27.22301Z","steps":["trace[923861852] 'agreement among raft nodes before linearized reading'  (duration: 218.173997ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:05:27.223144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:05:26.791Z","time spent":"432.064119ms","remote":"127.0.0.1:33868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-05-06T05:06:53.855478Z","caller":"traceutil/trace.go:171","msg":"trace[2001710849] linearizableReadLoop","detail":"{readStateIndex:1865; appliedIndex:1864; }","duration":"312.026593ms","start":"2026-05-06T05:06:53.543426Z","end":"2026-05-06T05:06:53.855453Z","steps":["trace[2001710849] 'read index received'  (duration: 311.959031ms)","trace[2001710849] 'applied index is now lower than readState.Index'  (duration: 66.442µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:06:53.855601Z","caller":"traceutil/trace.go:171","msg":"trace[1160339645] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"324.461917ms","start":"2026-05-06T05:06:53.531125Z","end":"2026-05-06T05:06:53.855587Z","steps":["trace[1160339645] 'process raft request'  (duration: 324.156128ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:06:53.855781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.328062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eebfee6b-6c63-456c-9f1d-06bff6dc8007\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-06T05:06:53.855885Z","caller":"traceutil/trace.go:171","msg":"trace[1964274740] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eebfee6b-6c63-456c-9f1d-06bff6dc8007; range_end:; response_count:1; response_revision:1794; }","duration":"312.492437ms","start":"2026-05-06T05:06:53.543371Z","end":"2026-05-06T05:06:53.855863Z","steps":["trace[1964274740] 'agreement among raft nodes before linearized reading'  (duration: 312.220729ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:06:53.855917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:53.531092Z","time spent":"324.546829ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1759 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T05:06:53.855987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:06:53.543349Z","time spent":"312.572868ms","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eebfee6b-6c63-456c-9f1d-06bff6dc8007\" "}
{"level":"warn","ts":"2026-05-06T05:06:53.869473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.903797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.30\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-06T05:06:53.869537Z","caller":"traceutil/trace.go:171","msg":"trace[1564990180] range","detail":"{range_begin:/registry/masterleases/199.19.213.30; range_end:; response_count:1; response_revision:1795; }","duration":"261.971559ms","start":"2026-05-06T05:06:53.60755Z","end":"2026-05-06T05:06:53.869522Z","steps":["trace[1564990180] 'agreement among raft nodes before linearized reading'  (duration: 261.867286ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:06:54.237532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.572894ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:06:54.237673Z","caller":"traceutil/trace.go:171","msg":"trace[1565623795] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1798; }","duration":"145.750509ms","start":"2026-05-06T05:06:54.091901Z","end":"2026-05-06T05:06:54.237651Z","steps":["trace[1565623795] 'range keys from in-memory index tree'  (duration: 145.549323ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:06:54.237768Z","caller":"traceutil/trace.go:171","msg":"trace[303548142] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"205.946992ms","start":"2026-05-06T05:06:54.031693Z","end":"2026-05-06T05:06:54.23764Z","steps":["trace[303548142] 'process raft request'  (duration: 117.01964ms)","trace[303548142] 'compare'  (duration: 88.623624ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:07:07.524187Z","caller":"traceutil/trace.go:171","msg":"trace[885496216] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"263.055639ms","start":"2026-05-06T05:07:07.261115Z","end":"2026-05-06T05:07:07.524171Z","steps":["trace[885496216] 'process raft request'  (duration: 262.927945ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:07:07.524497Z","caller":"traceutil/trace.go:171","msg":"trace[1062522838] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1980; }","duration":"183.614097ms","start":"2026-05-06T05:07:07.340818Z","end":"2026-05-06T05:07:07.524432Z","steps":["trace[1062522838] 'read index received'  (duration: 183.586326ms)","trace[1062522838] 'applied index is now lower than readState.Index'  (duration: 24.171µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:07:07.524687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.855754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-06T05:07:07.524718Z","caller":"traceutil/trace.go:171","msg":"trace[400346369] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1905; }","duration":"183.930156ms","start":"2026-05-06T05:07:07.340778Z","end":"2026-05-06T05:07:07.524708Z","steps":["trace[400346369] 'agreement among raft nodes before linearized reading'  (duration: 183.825673ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:07:37.438651Z","caller":"traceutil/trace.go:171","msg":"trace[173536005] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"130.791516ms","start":"2026-05-06T05:07:37.307822Z","end":"2026-05-06T05:07:37.438613Z","steps":["trace[173536005] 'process raft request'  (duration: 130.547449ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:07:43.871651Z","caller":"traceutil/trace.go:171","msg":"trace[1395029884] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"144.628146ms","start":"2026-05-06T05:07:43.726978Z","end":"2026-05-06T05:07:43.871606Z","steps":["trace[1395029884] 'process raft request'  (duration: 144.330478ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:07:44.552229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.737492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-05-06T05:07:44.552366Z","caller":"traceutil/trace.go:171","msg":"trace[290370409] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2116; }","duration":"340.076752ms","start":"2026-05-06T05:07:44.21225Z","end":"2026-05-06T05:07:44.552327Z","steps":["trace[290370409] 'range keys from in-memory index tree'  (duration: 339.473315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:07:44.552476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:07:44.212221Z","time spent":"340.204965ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-06T05:08:39.939177Z","caller":"traceutil/trace.go:171","msg":"trace[1440585954] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"139.122379ms","start":"2026-05-06T05:08:39.800032Z","end":"2026-05-06T05:08:39.939155Z","steps":["trace[1440585954] 'process raft request'  (duration: 138.970825ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:09:14.489844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.383482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-06T05:09:14.489926Z","caller":"traceutil/trace.go:171","msg":"trace[1254985187] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2795; }","duration":"151.514096ms","start":"2026-05-06T05:09:14.338394Z","end":"2026-05-06T05:09:14.489909Z","steps":["trace[1254985187] 'range keys from in-memory index tree'  (duration: 150.976801ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:09:14.540407Z","caller":"traceutil/trace.go:171","msg":"trace[1745766718] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"107.605838ms","start":"2026-05-06T05:09:14.432772Z","end":"2026-05-06T05:09:14.540378Z","steps":["trace[1745766718] 'process raft request'  (duration: 106.987461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:11:50.241124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.233496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-06T05:11:50.241275Z","caller":"traceutil/trace.go:171","msg":"trace[416897265] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3818; }","duration":"134.470843ms","start":"2026-05-06T05:11:50.106775Z","end":"2026-05-06T05:11:50.241246Z","steps":["trace[416897265] 'range keys from in-memory index tree'  (duration: 133.868926ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:13:06.991679Z","caller":"traceutil/trace.go:171","msg":"trace[767154233] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"103.281471ms","start":"2026-05-06T05:13:06.888357Z","end":"2026-05-06T05:13:06.991639Z","steps":["trace[767154233] 'process raft request'  (duration: 59.163379ms)","trace[767154233] 'compare'  (duration: 43.567406ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:13:16.858034Z","caller":"traceutil/trace.go:171","msg":"trace[1344904330] linearizableReadLoop","detail":"{readStateIndex:5213; appliedIndex:5212; }","duration":"148.592007ms","start":"2026-05-06T05:13:16.709417Z","end":"2026-05-06T05:13:16.858009Z","steps":["trace[1344904330] 'read index received'  (duration: 148.413001ms)","trace[1344904330] 'applied index is now lower than readState.Index'  (duration: 178.156µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:13:16.858069Z","caller":"traceutil/trace.go:171","msg":"trace[2062288845] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"151.240639ms","start":"2026-05-06T05:13:16.706804Z","end":"2026-05-06T05:13:16.858044Z","steps":["trace[2062288845] 'process raft request'  (duration: 151.078303ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:13:16.858292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.836383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T05:13:16.858385Z","caller":"traceutil/trace.go:171","msg":"trace[1288595212] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5017; }","duration":"148.995588ms","start":"2026-05-06T05:13:16.70937Z","end":"2026-05-06T05:13:16.858366Z","steps":["trace[1288595212] 'agreement among raft nodes before linearized reading'  (duration: 148.73366ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:13:34.704569Z","caller":"traceutil/trace.go:171","msg":"trace[2029050507] linearizableReadLoop","detail":"{readStateIndex:5607; appliedIndex:5606; }","duration":"106.693655ms","start":"2026-05-06T05:13:34.597841Z","end":"2026-05-06T05:13:34.704534Z","steps":["trace[2029050507] 'read index received'  (duration: 67.840459ms)","trace[2029050507] 'applied index is now lower than readState.Index'  (duration: 38.850456ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:13:34.704615Z","caller":"traceutil/trace.go:171","msg":"trace[1740307673] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"112.656211ms","start":"2026-05-06T05:13:34.591913Z","end":"2026-05-06T05:13:34.704569Z","steps":["trace[1740307673] 'process raft request'  (duration: 73.707872ms)","trace[1740307673] 'compare'  (duration: 38.686092ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:13:34.704926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.038134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-06T05:13:34.705036Z","caller":"traceutil/trace.go:171","msg":"trace[605739586] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5399; }","duration":"107.195479ms","start":"2026-05-06T05:13:34.597816Z","end":"2026-05-06T05:13:34.705012Z","steps":["trace[605739586] 'agreement among raft nodes before linearized reading'  (duration: 106.830119ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:13:34.967614Z","caller":"traceutil/trace.go:171","msg":"trace[1118679276] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"258.363556ms","start":"2026-05-06T05:13:34.709213Z","end":"2026-05-06T05:13:34.967577Z","steps":["trace[1118679276] 'process raft request'  (duration: 258.1326ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:13:35.073393Z","caller":"traceutil/trace.go:171","msg":"trace[1513495688] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"363.022487ms","start":"2026-05-06T05:13:34.710333Z","end":"2026-05-06T05:13:35.073356Z","steps":["trace[1513495688] 'process raft request'  (duration: 336.786269ms)","trace[1513495688] 'compare'  (duration: 26.042143ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:13:35.07357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:13:34.710306Z","time spent":"363.17375ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5290 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T05:14:50.506161Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2994}
{"level":"info","ts":"2026-05-06T05:14:50.573786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2994,"took":"65.157908ms","hash":1893251341,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":33763328,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-06T05:14:50.573871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1893251341,"revision":2994,"compact-revision":-1}
{"level":"info","ts":"2026-05-06T05:19:41.678724Z","caller":"traceutil/trace.go:171","msg":"trace[139775550] transaction","detail":"{read_only:false; response_revision:8229; number_of_response:1; }","duration":"149.288005ms","start":"2026-05-06T05:19:41.529408Z","end":"2026-05-06T05:19:41.678696Z","steps":["trace[139775550] 'process raft request'  (duration: 149.10442ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:19:50.514522Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6084}
{"level":"info","ts":"2026-05-06T05:19:50.621577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6084,"took":"104.530355ms","hash":2252113829,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":23056384,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-06T05:19:50.621651Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2252113829,"revision":6084,"compact-revision":2994}
{"level":"info","ts":"2026-05-06T05:19:54.999344Z","caller":"traceutil/trace.go:171","msg":"trace[656803286] transaction","detail":"{read_only:false; response_revision:8299; number_of_response:1; }","duration":"101.384298ms","start":"2026-05-06T05:19:54.897927Z","end":"2026-05-06T05:19:54.999311Z","steps":["trace[656803286] 'process raft request'  (duration: 100.620948ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:19:55.37221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.880845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-06T05:19:55.372223Z","caller":"traceutil/trace.go:171","msg":"trace[348042415] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"219.648192ms","start":"2026-05-06T05:19:55.152541Z","end":"2026-05-06T05:19:55.372189Z","steps":["trace[348042415] 'process raft request'  (duration: 213.655307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:19:55.372285Z","caller":"traceutil/trace.go:171","msg":"trace[214533935] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8301; }","duration":"220.992059ms","start":"2026-05-06T05:19:55.151278Z","end":"2026-05-06T05:19:55.37227Z","steps":["trace[214533935] 'range keys from in-memory index tree'  (duration: 220.695561ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:20:23.041002Z","caller":"traceutil/trace.go:171","msg":"trace[802643464] transaction","detail":"{read_only:false; response_revision:8502; number_of_response:1; }","duration":"257.326117ms","start":"2026-05-06T05:20:22.78365Z","end":"2026-05-06T05:20:23.040976Z","steps":["trace[802643464] 'process raft request'  (duration: 257.06908ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:20:25.319743Z","caller":"traceutil/trace.go:171","msg":"trace[442740676] transaction","detail":"{read_only:false; response_revision:8513; number_of_response:1; }","duration":"149.801131ms","start":"2026-05-06T05:20:25.169916Z","end":"2026-05-06T05:20:25.319717Z","steps":["trace[442740676] 'process raft request'  (duration: 132.474154ms)","trace[442740676] 'compare'  (duration: 16.890285ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:20:25.3199Z","caller":"traceutil/trace.go:171","msg":"trace[1555239973] linearizableReadLoop","detail":"{readStateIndex:8822; appliedIndex:8820; }","duration":"133.820091ms","start":"2026-05-06T05:20:25.186052Z","end":"2026-05-06T05:20:25.319872Z","steps":["trace[1555239973] 'read index received'  (duration: 116.32656ms)","trace[1555239973] 'applied index is now lower than readState.Index'  (duration: 17.492431ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:20:25.320087Z","caller":"traceutil/trace.go:171","msg":"trace[1863157238] transaction","detail":"{read_only:false; response_revision:8514; number_of_response:1; }","duration":"149.700238ms","start":"2026-05-06T05:20:25.170371Z","end":"2026-05-06T05:20:25.320072Z","steps":["trace[1863157238] 'process raft request'  (duration: 149.276217ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:20:25.32033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.257422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-06T05:20:25.320431Z","caller":"traceutil/trace.go:171","msg":"trace[2045251998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8514; }","duration":"134.396626ms","start":"2026-05-06T05:20:25.18601Z","end":"2026-05-06T05:20:25.320407Z","steps":["trace[2045251998] 'agreement among raft nodes before linearized reading'  (duration: 134.14824ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:20:35.632749Z","caller":"traceutil/trace.go:171","msg":"trace[170119517] transaction","detail":"{read_only:false; response_revision:8613; number_of_response:1; }","duration":"163.746293ms","start":"2026-05-06T05:20:35.468972Z","end":"2026-05-06T05:20:35.632718Z","steps":["trace[170119517] 'process raft request'  (duration: 135.700861ms)","trace[170119517] 'compare'  (duration: 27.849416ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:20:35.633274Z","caller":"traceutil/trace.go:171","msg":"trace[1070332170] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8614; }","duration":"162.686394ms","start":"2026-05-06T05:20:35.47056Z","end":"2026-05-06T05:20:35.633246Z","steps":["trace[1070332170] 'process raft request'  (duration: 162.082278ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:20:36.262489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.586467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-06T05:20:36.262633Z","caller":"traceutil/trace.go:171","msg":"trace[925108681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8619; }","duration":"144.746551ms","start":"2026-05-06T05:20:36.117834Z","end":"2026-05-06T05:20:36.262581Z","steps":["trace[925108681] 'range keys from in-memory index tree'  (duration: 144.419323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:20:36.262886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.173916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T05:20:36.262984Z","caller":"traceutil/trace.go:171","msg":"trace[1845915587] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:8619; }","duration":"128.353221ms","start":"2026-05-06T05:20:36.134611Z","end":"2026-05-06T05:20:36.262964Z","steps":["trace[1845915587] 'count revisions from in-memory index tree'  (duration: 128.022461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:20:36.572632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.49491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:20:36.572709Z","caller":"traceutil/trace.go:171","msg":"trace[1027598709] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:8620; }","duration":"170.626413ms","start":"2026-05-06T05:20:36.402061Z","end":"2026-05-06T05:20:36.572687Z","steps":["trace[1027598709] 'count revisions from in-memory index tree'  (duration: 170.398307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:20:36.597901Z","caller":"traceutil/trace.go:171","msg":"trace[314757821] linearizableReadLoop","detail":"{readStateIndex:8935; appliedIndex:8934; }","duration":"115.840087ms","start":"2026-05-06T05:20:36.48203Z","end":"2026-05-06T05:20:36.59787Z","steps":["trace[314757821] 'read index received'  (duration: 115.599531ms)","trace[314757821] 'applied index is now lower than readState.Index'  (duration: 238.246µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:20:36.598193Z","caller":"traceutil/trace.go:171","msg":"trace[1354512894] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"147.239ms","start":"2026-05-06T05:20:36.45078Z","end":"2026-05-06T05:20:36.598019Z","steps":["trace[1354512894] 'process raft request'  (duration: 146.87195ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:20:36.598219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.168706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"info","ts":"2026-05-06T05:20:36.598431Z","caller":"traceutil/trace.go:171","msg":"trace[542015412] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8621; }","duration":"116.394672ms","start":"2026-05-06T05:20:36.482019Z","end":"2026-05-06T05:20:36.598413Z","steps":["trace[542015412] 'agreement among raft nodes before linearized reading'  (duration: 116.011541ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:21:20.180648Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002480.wal"}
{"level":"info","ts":"2026-05-06T05:22:30.941724Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2b5783e11defe7e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-06T05:22:30.953016Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-06T05:22:30.95316Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-06T05:24:50.52266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8275}
{"level":"info","ts":"2026-05-06T05:24:50.601399Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8275,"took":"76.209633ms","hash":1888515760,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":25325568,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-06T05:24:50.601478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1888515760,"revision":8275,"compact-revision":6084}
{"level":"info","ts":"2026-05-06T05:25:13.105779Z","caller":"traceutil/trace.go:171","msg":"trace[779161200] linearizableReadLoop","detail":"{readStateIndex:11470; appliedIndex:11468; }","duration":"102.64189ms","start":"2026-05-06T05:25:13.003111Z","end":"2026-05-06T05:25:13.105753Z","steps":["trace[779161200] 'read index received'  (duration: 61.451708ms)","trace[779161200] 'applied index is now lower than readState.Index'  (duration: 41.189022ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:25:13.1059Z","caller":"traceutil/trace.go:171","msg":"trace[1174432315] transaction","detail":"{read_only:false; response_revision:11087; number_of_response:1; }","duration":"113.057826ms","start":"2026-05-06T05:25:12.99279Z","end":"2026-05-06T05:25:13.105847Z","steps":["trace[1174432315] 'process raft request'  (duration: 112.874251ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:25:13.106042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.864355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:25:13.106125Z","caller":"traceutil/trace.go:171","msg":"trace[253746574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11087; }","duration":"103.05856ms","start":"2026-05-06T05:25:13.003054Z","end":"2026-05-06T05:25:13.106113Z","steps":["trace[253746574] 'agreement among raft nodes before linearized reading'  (duration: 102.875316ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:25:13.234778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.338803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-06T05:25:13.234861Z","caller":"traceutil/trace.go:171","msg":"trace[1201769590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11087; }","duration":"105.511718ms","start":"2026-05-06T05:25:13.129328Z","end":"2026-05-06T05:25:13.23484Z","steps":["trace[1201769590] 'range keys from in-memory index tree'  (duration: 105.087327ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:25:32.035865Z","caller":"traceutil/trace.go:171","msg":"trace[1433878689] linearizableReadLoop","detail":"{readStateIndex:11583; appliedIndex:11582; }","duration":"175.982864ms","start":"2026-05-06T05:25:31.859855Z","end":"2026-05-06T05:25:32.035838Z","steps":["trace[1433878689] 'read index received'  (duration: 175.704706ms)","trace[1433878689] 'applied index is now lower than readState.Index'  (duration: 277.347µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:25:32.035997Z","caller":"traceutil/trace.go:171","msg":"trace[2002069409] transaction","detail":"{read_only:false; response_revision:11196; number_of_response:1; }","duration":"179.141091ms","start":"2026-05-06T05:25:31.856828Z","end":"2026-05-06T05:25:32.035969Z","steps":["trace[2002069409] 'process raft request'  (duration: 178.813992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:25:32.036292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.387395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:25:32.036365Z","caller":"traceutil/trace.go:171","msg":"trace[1593302505] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11196; }","duration":"176.496048ms","start":"2026-05-06T05:25:31.85985Z","end":"2026-05-06T05:25:32.036346Z","steps":["trace[1593302505] 'agreement among raft nodes before linearized reading'  (duration: 176.375905ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:25:32.036362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.499028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"}
{"level":"info","ts":"2026-05-06T05:25:32.036543Z","caller":"traceutil/trace.go:171","msg":"trace[1516792158] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11196; }","duration":"176.718654ms","start":"2026-05-06T05:25:31.859806Z","end":"2026-05-06T05:25:32.036525Z","steps":["trace[1516792158] 'agreement among raft nodes before linearized reading'  (duration: 176.18212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:25:32.036516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.827778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T05:25:32.036613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.154588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:25:32.036666Z","caller":"traceutil/trace.go:171","msg":"trace[288951971] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11196; }","duration":"175.983843ms","start":"2026-05-06T05:25:31.860646Z","end":"2026-05-06T05:25:32.03663Z","steps":["trace[288951971] 'agreement among raft nodes before linearized reading'  (duration: 175.745086ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:25:32.036646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.413727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T05:25:32.036724Z","caller":"traceutil/trace.go:171","msg":"trace[131744253] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11196; }","duration":"176.315733ms","start":"2026-05-06T05:25:31.860383Z","end":"2026-05-06T05:25:32.036699Z","steps":["trace[131744253] 'agreement among raft nodes before linearized reading'  (duration: 176.122468ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:25:32.036746Z","caller":"traceutil/trace.go:171","msg":"trace[1136348626] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11196; }","duration":"175.54396ms","start":"2026-05-06T05:25:31.861179Z","end":"2026-05-06T05:25:32.036723Z","steps":["trace[1136348626] 'agreement among raft nodes before linearized reading'  (duration: 175.343685ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:25:32.788958Z","caller":"traceutil/trace.go:171","msg":"trace[2126832352] transaction","detail":"{read_only:false; response_revision:11199; number_of_response:1; }","duration":"101.529439ms","start":"2026-05-06T05:25:32.687399Z","end":"2026-05-06T05:25:32.788929Z","steps":["trace[2126832352] 'process raft request'  (duration: 101.334374ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:29:50.528604Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10778}
{"level":"info","ts":"2026-05-06T05:29:50.617557Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10778,"took":"86.5436ms","hash":3642495342,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":27803648,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-06T05:29:50.617643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3642495342,"revision":10778,"compact-revision":8275}
{"level":"info","ts":"2026-05-06T05:31:53.584035Z","caller":"traceutil/trace.go:171","msg":"trace[1979017928] linearizableReadLoop","detail":"{readStateIndex:14239; appliedIndex:14238; }","duration":"125.778804ms","start":"2026-05-06T05:31:53.458222Z","end":"2026-05-06T05:31:53.584001Z","steps":["trace[1979017928] 'read index received'  (duration: 125.435125ms)","trace[1979017928] 'applied index is now lower than readState.Index'  (duration: 342.509µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:31:53.584566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.326199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-06T05:31:53.584616Z","caller":"traceutil/trace.go:171","msg":"trace[996501704] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13761; }","duration":"126.412862ms","start":"2026-05-06T05:31:53.458187Z","end":"2026-05-06T05:31:53.5846Z","steps":["trace[996501704] 'agreement among raft nodes before linearized reading'  (duration: 126.243997ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:31:53.58486Z","caller":"traceutil/trace.go:171","msg":"trace[1801140772] transaction","detail":"{read_only:false; response_revision:13761; number_of_response:1; }","duration":"167.374514ms","start":"2026-05-06T05:31:53.417466Z","end":"2026-05-06T05:31:53.584841Z","steps":["trace[1801140772] 'process raft request'  (duration: 166.334746ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:31:53.732059Z","caller":"traceutil/trace.go:171","msg":"trace[2143454117] transaction","detail":"{read_only:false; response_revision:13762; number_of_response:1; }","duration":"143.570312ms","start":"2026-05-06T05:31:53.588448Z","end":"2026-05-06T05:31:53.732019Z","steps":["trace[2143454117] 'process raft request'  (duration: 105.561191ms)","trace[2143454117] 'compare'  (duration: 37.639941ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:31:53.732456Z","caller":"traceutil/trace.go:171","msg":"trace[1057168572] linearizableReadLoop","detail":"{readStateIndex:14241; appliedIndex:14239; }","duration":"140.948259ms","start":"2026-05-06T05:31:53.591486Z","end":"2026-05-06T05:31:53.732434Z","steps":["trace[1057168572] 'read index received'  (duration: 102.539697ms)","trace[1057168572] 'applied index is now lower than readState.Index'  (duration: 38.407242ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:31:53.732991Z","caller":"traceutil/trace.go:171","msg":"trace[395248376] transaction","detail":"{read_only:false; response_revision:13763; number_of_response:1; }","duration":"143.193562ms","start":"2026-05-06T05:31:53.58977Z","end":"2026-05-06T05:31:53.732964Z","steps":["trace[395248376] 'process raft request'  (duration: 142.516383ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:31:53.733288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.761312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:63 size:594896"}
{"level":"info","ts":"2026-05-06T05:31:53.733342Z","caller":"traceutil/trace.go:171","msg":"trace[783124116] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:63; response_revision:13763; }","duration":"141.876235ms","start":"2026-05-06T05:31:53.591453Z","end":"2026-05-06T05:31:53.733329Z","steps":["trace[783124116] 'agreement among raft nodes before linearized reading'  (duration: 141.121605ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:32:14.899002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.53951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-12de0be1-bcd2-4a63-aa96-8d13a215e6d1\" ","response":"range_response_count:1 size:3636"}
{"level":"info","ts":"2026-05-06T05:32:14.899125Z","caller":"traceutil/trace.go:171","msg":"trace[243755140] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-12de0be1-bcd2-4a63-aa96-8d13a215e6d1; range_end:; response_count:1; response_revision:14066; }","duration":"183.680885ms","start":"2026-05-06T05:32:14.715421Z","end":"2026-05-06T05:32:14.899102Z","steps":["trace[243755140] 'range keys from in-memory index tree'  (duration: 183.274154ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:33:40.388425Z","caller":"traceutil/trace.go:171","msg":"trace[1605125903] transaction","detail":"{read_only:false; response_revision:14874; number_of_response:1; }","duration":"159.249935ms","start":"2026-05-06T05:33:40.229148Z","end":"2026-05-06T05:33:40.388398Z","steps":["trace[1605125903] 'process raft request'  (duration: 159.075171ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:33:40.428758Z","caller":"traceutil/trace.go:171","msg":"trace[1856004336] transaction","detail":"{read_only:false; response_revision:14875; number_of_response:1; }","duration":"197.138283ms","start":"2026-05-06T05:33:40.231594Z","end":"2026-05-06T05:33:40.428732Z","steps":["trace[1856004336] 'process raft request'  (duration: 196.912927ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:33:40.428976Z","caller":"traceutil/trace.go:171","msg":"trace[2006577606] linearizableReadLoop","detail":"{readStateIndex:15390; appliedIndex:15388; }","duration":"167.921703ms","start":"2026-05-06T05:33:40.261005Z","end":"2026-05-06T05:33:40.428927Z","steps":["trace[2006577606] 'read index received'  (duration: 127.264251ms)","trace[2006577606] 'applied index is now lower than readState.Index'  (duration: 40.655022ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:33:40.429195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.16907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-05-06T05:33:40.429262Z","caller":"traceutil/trace.go:171","msg":"trace[2066033142] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14877; }","duration":"168.290783ms","start":"2026-05-06T05:33:40.260954Z","end":"2026-05-06T05:33:40.429245Z","steps":["trace[2066033142] 'agreement among raft nodes before linearized reading'  (duration: 168.107418ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:33:40.42933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.104315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-06T05:33:40.429384Z","caller":"traceutil/trace.go:171","msg":"trace[848157661] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14877; }","duration":"116.210638ms","start":"2026-05-06T05:33:40.313158Z","end":"2026-05-06T05:33:40.429368Z","steps":["trace[848157661] 'agreement among raft nodes before linearized reading'  (duration: 115.992882ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:33:40.633932Z","caller":"traceutil/trace.go:171","msg":"trace[1883135260] linearizableReadLoop","detail":"{readStateIndex:15394; appliedIndex:15393; }","duration":"104.621832ms","start":"2026-05-06T05:33:40.529279Z","end":"2026-05-06T05:33:40.633901Z","steps":["trace[1883135260] 'read index received'  (duration: 104.469248ms)","trace[1883135260] 'applied index is now lower than readState.Index'  (duration: 151.284µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:33:40.634173Z","caller":"traceutil/trace.go:171","msg":"trace[1761507455] transaction","detail":"{read_only:false; response_revision:14879; number_of_response:1; }","duration":"130.253972ms","start":"2026-05-06T05:33:40.50389Z","end":"2026-05-06T05:33:40.634144Z","steps":["trace[1761507455] 'process raft request'  (duration: 129.849751ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:33:40.634223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.902339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T05:33:40.634325Z","caller":"traceutil/trace.go:171","msg":"trace[1403100636] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:14879; }","duration":"105.067483ms","start":"2026-05-06T05:33:40.529233Z","end":"2026-05-06T05:33:40.6343Z","steps":["trace[1403100636] 'agreement among raft nodes before linearized reading'  (duration: 104.845347ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:34:50.534615Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12949}
{"level":"info","ts":"2026-05-06T05:34:50.615795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12949,"took":"78.478577ms","hash":1402218088,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":30560256,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-06T05:34:50.616011Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1402218088,"revision":12949,"compact-revision":10778}
{"level":"info","ts":"2026-05-06T05:39:12.486556Z","caller":"traceutil/trace.go:171","msg":"trace[1131374865] linearizableReadLoop","detail":"{readStateIndex:17951; appliedIndex:17950; }","duration":"162.425641ms","start":"2026-05-06T05:39:12.324101Z","end":"2026-05-06T05:39:12.486526Z","steps":["trace[1131374865] 'read index received'  (duration: 157.718143ms)","trace[1131374865] 'applied index is now lower than readState.Index'  (duration: 4.706238ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:39:12.486621Z","caller":"traceutil/trace.go:171","msg":"trace[60912372] transaction","detail":"{read_only:false; response_revision:17354; number_of_response:1; }","duration":"180.974087ms","start":"2026-05-06T05:39:12.305611Z","end":"2026-05-06T05:39:12.486585Z","steps":["trace[60912372] 'process raft request'  (duration: 176.272299ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:12.48681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.679798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-06T05:39:12.486858Z","caller":"traceutil/trace.go:171","msg":"trace[1786012006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17354; }","duration":"162.797141ms","start":"2026-05-06T05:39:12.324048Z","end":"2026-05-06T05:39:12.486845Z","steps":["trace[1786012006] 'agreement among raft nodes before linearized reading'  (duration: 162.591916ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:39:18.610751Z","caller":"traceutil/trace.go:171","msg":"trace[475971459] transaction","detail":"{read_only:false; response_revision:17408; number_of_response:1; }","duration":"154.583956ms","start":"2026-05-06T05:39:18.456145Z","end":"2026-05-06T05:39:18.610729Z","steps":["trace[475971459] 'process raft request'  (duration: 154.417491ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.006259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.315063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:39:19.006387Z","caller":"traceutil/trace.go:171","msg":"trace[244920122] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:17410; }","duration":"145.501648ms","start":"2026-05-06T05:39:18.860856Z","end":"2026-05-06T05:39:19.006358Z","steps":["trace[244920122] 'count revisions from in-memory index tree'  (duration: 145.238631ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.00652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.149767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-05-06T05:39:19.006595Z","caller":"traceutil/trace.go:171","msg":"trace[1084458076] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:17410; }","duration":"225.26602ms","start":"2026-05-06T05:39:18.781311Z","end":"2026-05-06T05:39:19.006577Z","steps":["trace[1084458076] 'range keys from in-memory index tree'  (duration: 225.017383ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.006834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.098407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-gdpvl\" ","response":"range_response_count:1 size:22128"}
{"level":"info","ts":"2026-05-06T05:39:19.006861Z","caller":"traceutil/trace.go:171","msg":"trace[703969115] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-gdpvl; range_end:; response_count:1; response_revision:17410; }","duration":"217.163069ms","start":"2026-05-06T05:39:18.789691Z","end":"2026-05-06T05:39:19.006854Z","steps":["trace[703969115] 'range keys from in-memory index tree'  (duration: 216.973474ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.430439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.620196ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958394518 > lease_revoke:<id:7e7e9dfbaca9b74a>","response":"size:29"}
{"level":"info","ts":"2026-05-06T05:39:19.430722Z","caller":"traceutil/trace.go:171","msg":"trace[2019254380] linearizableReadLoop","detail":"{readStateIndex:18009; appliedIndex:18008; }","duration":"511.206827ms","start":"2026-05-06T05:39:18.919484Z","end":"2026-05-06T05:39:19.430691Z","steps":["trace[2019254380] 'read index received'  (duration: 179.405905ms)","trace[2019254380] 'applied index is now lower than readState.Index'  (duration: 331.798332ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:39:19.430995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.490914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:39:19.431089Z","caller":"traceutil/trace.go:171","msg":"trace[1722638543] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17410; }","duration":"511.630998ms","start":"2026-05-06T05:39:18.919434Z","end":"2026-05-06T05:39:19.431065Z","steps":["trace[1722638543] 'agreement among raft nodes before linearized reading'  (duration: 511.376511ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.431129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:39:18.919405Z","time spent":"511.71555ms","remote":"127.0.0.1:33532","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-05-06T05:39:19.431205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.517528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:39:19.431228Z","caller":"traceutil/trace.go:171","msg":"trace[1471067556] transaction","detail":"{read_only:false; response_revision:17411; number_of_response:1; }","duration":"419.839699ms","start":"2026-05-06T05:39:19.011376Z","end":"2026-05-06T05:39:19.431215Z","steps":["trace[1471067556] 'process raft request'  (duration: 419.169301ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:39:19.431277Z","caller":"traceutil/trace.go:171","msg":"trace[1407705570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17411; }","duration":"427.626362ms","start":"2026-05-06T05:39:19.003624Z","end":"2026-05-06T05:39:19.431251Z","steps":["trace[1407705570] 'agreement among raft nodes before linearized reading'  (duration: 427.524259ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.43133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:39:19.011356Z","time spent":"419.906531ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:17297 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T05:39:19.431337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:39:19.003604Z","time spent":"427.720514ms","remote":"127.0.0.1:59566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-06T05:39:19.43134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.138363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-05-06T05:39:19.431365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.600774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-mbghg\" ","response":"range_response_count:1 size:9799"}
{"level":"info","ts":"2026-05-06T05:39:19.431406Z","caller":"traceutil/trace.go:171","msg":"trace[514891253] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-mbghg; range_end:; response_count:1; response_revision:17411; }","duration":"362.642185ms","start":"2026-05-06T05:39:19.068753Z","end":"2026-05-06T05:39:19.431396Z","steps":["trace[514891253] 'agreement among raft nodes before linearized reading'  (duration: 362.483081ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:39:19.431409Z","caller":"traceutil/trace.go:171","msg":"trace[223977659] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17411; }","duration":"350.251427ms","start":"2026-05-06T05:39:19.08114Z","end":"2026-05-06T05:39:19.431392Z","steps":["trace[223977659] 'agreement among raft nodes before linearized reading'  (duration: 350.050461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.431434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:39:19.068692Z","time spent":"362.736078ms","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9822,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-mbghg\" "}
{"level":"warn","ts":"2026-05-06T05:39:19.431456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:39:19.081112Z","time spent":"350.331708ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T05:39:19.431866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.383119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946756"}
{"level":"info","ts":"2026-05-06T05:39:19.4319Z","caller":"traceutil/trace.go:171","msg":"trace[2040352306] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:17411; }","duration":"418.41758ms","start":"2026-05-06T05:39:19.013474Z","end":"2026-05-06T05:39:19.431892Z","steps":["trace[2040352306] 'agreement among raft nodes before linearized reading'  (duration: 417.776363ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:39:19.431924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:39:19.013444Z","time spent":"418.471632ms","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":94,"response size":946779,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-05-06T05:39:50.541028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15335}
{"level":"info","ts":"2026-05-06T05:39:50.648072Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15335,"took":"103.799728ms","hash":2234801564,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":32436224,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-06T05:39:50.648127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2234801564,"revision":15335,"compact-revision":12949}
{"level":"info","ts":"2026-05-06T05:43:15.665364Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2b5783e11defe7e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-06T05:43:15.670269Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-06T05:43:15.670912Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-06T05:44:50.547536Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17753}
{"level":"info","ts":"2026-05-06T05:44:50.646452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17753,"took":"95.21774ms","hash":621776824,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":33865728,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-06T05:44:50.646575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":621776824,"revision":17753,"compact-revision":15335}
{"level":"info","ts":"2026-05-06T05:44:51.996196Z","caller":"traceutil/trace.go:171","msg":"trace[411728789] transaction","detail":"{read_only:false; response_revision:20028; number_of_response:1; }","duration":"275.537026ms","start":"2026-05-06T05:44:51.720623Z","end":"2026-05-06T05:44:51.99616Z","steps":["trace[411728789] 'process raft request'  (duration: 275.387282ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:52.168421Z","caller":"traceutil/trace.go:171","msg":"trace[1356410098] linearizableReadLoop","detail":"{readStateIndex:20713; appliedIndex:20711; }","duration":"309.217664ms","start":"2026-05-06T05:44:51.859169Z","end":"2026-05-06T05:44:52.168386Z","steps":["trace[1356410098] 'read index received'  (duration: 136.933409ms)","trace[1356410098] 'applied index is now lower than readState.Index'  (duration: 172.283105ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:44:52.168568Z","caller":"traceutil/trace.go:171","msg":"trace[854075917] transaction","detail":"{read_only:false; response_revision:20029; number_of_response:1; }","duration":"331.099841ms","start":"2026-05-06T05:44:51.83743Z","end":"2026-05-06T05:44:52.16853Z","steps":["trace[854075917] 'process raft request'  (duration: 299.324414ms)","trace[854075917] 'compare'  (duration: 31.476899ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:44:52.168739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:44:51.837412Z","time spent":"331.239086ms","remote":"127.0.0.1:33620","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:20016 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-06T05:44:52.168743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.557163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-06T05:44:52.168808Z","caller":"traceutil/trace.go:171","msg":"trace[876332541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20029; }","duration":"309.674996ms","start":"2026-05-06T05:44:51.859112Z","end":"2026-05-06T05:44:52.168787Z","steps":["trace[876332541] 'agreement among raft nodes before linearized reading'  (duration: 309.473221ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:44:52.168852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:44:51.859079Z","time spent":"309.760889ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-06T05:44:52.168982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.710064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-05-06T05:44:52.168976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.290864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:44:52.169076Z","caller":"traceutil/trace.go:171","msg":"trace[1181346252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20029; }","duration":"184.856599ms","start":"2026-05-06T05:44:51.984198Z","end":"2026-05-06T05:44:52.169054Z","steps":["trace[1181346252] 'agreement among raft nodes before linearized reading'  (duration: 184.569721ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:52.169104Z","caller":"traceutil/trace.go:171","msg":"trace[886193867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20029; }","duration":"165.494989ms","start":"2026-05-06T05:44:52.003585Z","end":"2026-05-06T05:44:52.16908Z","steps":["trace[886193867] 'agreement among raft nodes before linearized reading'  (duration: 165.258493ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:52.413477Z","caller":"traceutil/trace.go:171","msg":"trace[762035672] transaction","detail":"{read_only:false; response_revision:20030; number_of_response:1; }","duration":"240.605451ms","start":"2026-05-06T05:44:52.172837Z","end":"2026-05-06T05:44:52.413442Z","steps":["trace[762035672] 'process raft request'  (duration: 140.876867ms)","trace[762035672] 'compare'  (duration: 99.522959ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:44:52.413792Z","caller":"traceutil/trace.go:171","msg":"trace[672501585] linearizableReadLoop","detail":"{readStateIndex:20716; appliedIndex:20713; }","duration":"210.996573ms","start":"2026-05-06T05:44:52.202768Z","end":"2026-05-06T05:44:52.413765Z","steps":["trace[672501585] 'read index received'  (duration: 110.9328ms)","trace[672501585] 'applied index is now lower than readState.Index'  (duration: 100.062693ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:44:52.41411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.321242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:44:52.414197Z","caller":"traceutil/trace.go:171","msg":"trace[1249549366] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:20032; }","duration":"211.504737ms","start":"2026-05-06T05:44:52.202658Z","end":"2026-05-06T05:44:52.414163Z","steps":["trace[1249549366] 'agreement among raft nodes before linearized reading'  (duration: 211.385814ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:44:52.414242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.140065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-05-06T05:44:52.414296Z","caller":"traceutil/trace.go:171","msg":"trace[1703450392] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:20032; }","duration":"163.254228ms","start":"2026-05-06T05:44:52.251025Z","end":"2026-05-06T05:44:52.414279Z","steps":["trace[1703450392] 'agreement among raft nodes before linearized reading'  (duration: 163.093394ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:52.414451Z","caller":"traceutil/trace.go:171","msg":"trace[550930278] transaction","detail":"{read_only:false; response_revision:20031; number_of_response:1; }","duration":"241.044983ms","start":"2026-05-06T05:44:52.173371Z","end":"2026-05-06T05:44:52.414416Z","steps":["trace[550930278] 'process raft request'  (duration: 240.019995ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:52.4146Z","caller":"traceutil/trace.go:171","msg":"trace[1610041731] transaction","detail":"{read_only:false; response_revision:20032; number_of_response:1; }","duration":"240.429226ms","start":"2026-05-06T05:44:52.174157Z","end":"2026-05-06T05:44:52.414587Z","steps":["trace[1610041731] 'process raft request'  (duration: 239.46924ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:44:52.415821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.382685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-06T05:44:52.415877Z","caller":"traceutil/trace.go:171","msg":"trace[1633297145] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:20032; }","duration":"162.467607ms","start":"2026-05-06T05:44:52.253397Z","end":"2026-05-06T05:44:52.415865Z","steps":["trace[1633297145] 'agreement among raft nodes before linearized reading'  (duration: 161.336216ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:52.669603Z","caller":"traceutil/trace.go:171","msg":"trace[1719105396] linearizableReadLoop","detail":"{readStateIndex:20717; appliedIndex:20716; }","duration":"249.34487ms","start":"2026-05-06T05:44:52.42023Z","end":"2026-05-06T05:44:52.669575Z","steps":["trace[1719105396] 'read index received'  (duration: 59.822µs)","trace[1719105396] 'applied index is now lower than readState.Index'  (duration: 249.283998ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:44:52.66964Z","caller":"traceutil/trace.go:171","msg":"trace[1019036866] transaction","detail":"{read_only:false; response_revision:20033; number_of_response:1; }","duration":"249.38312ms","start":"2026-05-06T05:44:52.42021Z","end":"2026-05-06T05:44:52.669593Z","steps":["trace[1019036866] 'process raft request'  (duration: 235.531572ms)","trace[1019036866] 'compare'  (duration: 13.577791ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:44:52.669839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.593696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5aba9932-da5f-4b58-b94a-8ebb5ae2b04e\" ","response":"range_response_count:1 size:1318"}
{"level":"info","ts":"2026-05-06T05:44:52.669882Z","caller":"traceutil/trace.go:171","msg":"trace[1085915421] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5aba9932-da5f-4b58-b94a-8ebb5ae2b04e; range_end:; response_count:1; response_revision:20033; }","duration":"249.689519ms","start":"2026-05-06T05:44:52.420182Z","end":"2026-05-06T05:44:52.669871Z","steps":["trace[1085915421] 'agreement among raft nodes before linearized reading'  (duration: 249.536234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:44:53.001691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.759099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:44:53.001797Z","caller":"traceutil/trace.go:171","msg":"trace[581183548] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:20033; }","duration":"164.914914ms","start":"2026-05-06T05:44:52.836858Z","end":"2026-05-06T05:44:53.001772Z","steps":["trace[581183548] 'count revisions from in-memory index tree'  (duration: 164.686268ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:53.429343Z","caller":"traceutil/trace.go:171","msg":"trace[139505008] transaction","detail":"{read_only:false; response_revision:20036; number_of_response:1; }","duration":"171.144794ms","start":"2026-05-06T05:44:53.258156Z","end":"2026-05-06T05:44:53.429301Z","steps":["trace[139505008] 'process raft request'  (duration: 170.840995ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:44:53.588362Z","caller":"traceutil/trace.go:171","msg":"trace[1271463894] transaction","detail":"{read_only:false; response_revision:20037; number_of_response:1; }","duration":"154.282383ms","start":"2026-05-06T05:44:53.434035Z","end":"2026-05-06T05:44:53.588317Z","steps":["trace[1271463894] 'process raft request'  (duration: 112.43586ms)","trace[1271463894] 'compare'  (duration: 41.599076ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:48:46.135822Z","caller":"traceutil/trace.go:171","msg":"trace[1573511105] linearizableReadLoop","detail":"{readStateIndex:23210; appliedIndex:23209; }","duration":"235.816917ms","start":"2026-05-06T05:48:45.899974Z","end":"2026-05-06T05:48:46.135791Z","steps":["trace[1573511105] 'read index received'  (duration: 235.704514ms)","trace[1573511105] 'applied index is now lower than readState.Index'  (duration: 111.323µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:48:46.135956Z","caller":"traceutil/trace.go:171","msg":"trace[1373174927] transaction","detail":"{read_only:false; response_revision:22449; number_of_response:1; }","duration":"297.564321ms","start":"2026-05-06T05:48:45.838351Z","end":"2026-05-06T05:48:46.135916Z","steps":["trace[1373174927] 'process raft request'  (duration: 297.263213ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:48:46.136165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.148236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-06T05:48:46.13623Z","caller":"traceutil/trace.go:171","msg":"trace[1452748371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22449; }","duration":"236.285219ms","start":"2026-05-06T05:48:45.89993Z","end":"2026-05-06T05:48:46.136215Z","steps":["trace[1452748371] 'agreement among raft nodes before linearized reading'  (duration: 235.993961ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:48:46.141987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.037806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager\" ","response":"range_response_count:1 size:5140"}
{"level":"info","ts":"2026-05-06T05:48:46.142085Z","caller":"traceutil/trace.go:171","msg":"trace[790567436] range","detail":"{range_begin:/registry/deployments/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager; range_end:; response_count:1; response_revision:22451; }","duration":"183.18252ms","start":"2026-05-06T05:48:45.958882Z","end":"2026-05-06T05:48:46.142064Z","steps":["trace[790567436] 'agreement among raft nodes before linearized reading'  (duration: 182.948874ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:48:46.142408Z","caller":"traceutil/trace.go:171","msg":"trace[1197692619] transaction","detail":"{read_only:false; response_revision:22451; number_of_response:1; }","duration":"160.429398ms","start":"2026-05-06T05:48:45.981954Z","end":"2026-05-06T05:48:46.142384Z","steps":["trace[1197692619] 'process raft request'  (duration: 159.828452ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:48:46.142422Z","caller":"traceutil/trace.go:171","msg":"trace[945587204] transaction","detail":"{read_only:false; response_revision:22450; number_of_response:1; }","duration":"161.894109ms","start":"2026-05-06T05:48:45.980472Z","end":"2026-05-06T05:48:46.142366Z","steps":["trace[945587204] 'process raft request'  (duration: 161.18398ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:48:46.14272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.30165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:48:46.142781Z","caller":"traceutil/trace.go:171","msg":"trace[555924018] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22451; }","duration":"114.420763ms","start":"2026-05-06T05:48:46.028345Z","end":"2026-05-06T05:48:46.142766Z","steps":["trace[555924018] 'agreement among raft nodes before linearized reading'  (duration: 114.101074ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:48:46.278703Z","caller":"traceutil/trace.go:171","msg":"trace[1364868543] transaction","detail":"{read_only:false; response_revision:22452; number_of_response:1; }","duration":"138.215602ms","start":"2026-05-06T05:48:46.140426Z","end":"2026-05-06T05:48:46.278641Z","steps":["trace[1364868543] 'process raft request'  (duration: 39.185889ms)","trace[1364868543] 'compare'  (duration: 98.868499ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:48:46.278727Z","caller":"traceutil/trace.go:171","msg":"trace[1419829667] linearizableReadLoop","detail":"{readStateIndex:23213; appliedIndex:23212; }","duration":"131.135269ms","start":"2026-05-06T05:48:46.14755Z","end":"2026-05-06T05:48:46.278686Z","steps":["trace[1419829667] 'read index received'  (duration: 32.074965ms)","trace[1419829667] 'applied index is now lower than readState.Index'  (duration: 99.055383ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:48:46.279119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.55158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:48:46.279164Z","caller":"traceutil/trace.go:171","msg":"trace[138894824] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22453; }","duration":"131.629772ms","start":"2026-05-06T05:48:46.147523Z","end":"2026-05-06T05:48:46.279153Z","steps":["trace[138894824] 'agreement among raft nodes before linearized reading'  (duration: 131.276393ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:49:50.555438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20022}
{"level":"info","ts":"2026-05-06T05:49:50.664117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20022,"took":"103.188997ms","hash":1290697635,"current-db-size-bytes":56770560,"current-db-size":"57 MB","current-db-size-in-use-bytes":41267200,"current-db-size-in-use":"41 MB"}
{"level":"info","ts":"2026-05-06T05:49:50.664209Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1290697635,"revision":20022,"compact-revision":17753}
{"level":"info","ts":"2026-05-06T05:52:05.169219Z","caller":"traceutil/trace.go:171","msg":"trace[864305844] transaction","detail":"{read_only:false; response_revision:24501; number_of_response:1; }","duration":"212.586722ms","start":"2026-05-06T05:52:04.956612Z","end":"2026-05-06T05:52:05.169198Z","steps":["trace[864305844] 'process raft request'  (duration: 212.445028ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.348845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.161075ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414285 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24482 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:05.349022Z","caller":"traceutil/trace.go:171","msg":"trace[1001121211] transaction","detail":"{read_only:false; response_revision:24503; number_of_response:1; }","duration":"136.066814ms","start":"2026-05-06T05:52:05.212939Z","end":"2026-05-06T05:52:05.349006Z","steps":["trace[1001121211] 'process raft request'  (duration: 136.008062ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:05.349327Z","caller":"traceutil/trace.go:171","msg":"trace[883711238] linearizableReadLoop","detail":"{readStateIndex:25315; appliedIndex:25313; }","duration":"340.281767ms","start":"2026-05-06T05:52:05.009017Z","end":"2026-05-06T05:52:05.349298Z","steps":["trace[883711238] 'read index received'  (duration: 160.081959ms)","trace[883711238] 'applied index is now lower than readState.Index'  (duration: 180.198228ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:05.34948Z","caller":"traceutil/trace.go:171","msg":"trace[1127294069] transaction","detail":"{read_only:false; response_revision:24502; number_of_response:1; }","duration":"377.872713ms","start":"2026-05-06T05:52:04.971593Z","end":"2026-05-06T05:52:05.349466Z","steps":["trace[1127294069] 'process raft request'  (duration: 226.009569ms)","trace[1127294069] 'compare'  (duration: 150.390404ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:05.349589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:04.971571Z","time spent":"377.937745ms","remote":"127.0.0.1:33620","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:24482 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:05.349655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.73536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-05-06T05:52:05.349707Z","caller":"traceutil/trace.go:171","msg":"trace[49362997] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24503; }","duration":"325.817592ms","start":"2026-05-06T05:52:05.023875Z","end":"2026-05-06T05:52:05.349693Z","steps":["trace[49362997] 'agreement among raft nodes before linearized reading'  (duration: 325.674648ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.350008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.432911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-06T05:52:05.350047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.151478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:05.350133Z","caller":"traceutil/trace.go:171","msg":"trace[138440817] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:24503; }","duration":"194.268792ms","start":"2026-05-06T05:52:05.155845Z","end":"2026-05-06T05:52:05.350114Z","steps":["trace[138440817] 'agreement among raft nodes before linearized reading'  (duration: 194.099337ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.350184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.16273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:05.350248Z","caller":"traceutil/trace.go:171","msg":"trace[1033215899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24503; }","duration":"341.268723ms","start":"2026-05-06T05:52:05.008965Z","end":"2026-05-06T05:52:05.350234Z","steps":["trace[1033215899] 'agreement among raft nodes before linearized reading'  (duration: 341.1758ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.350267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.008946Z","time spent":"341.316385ms","remote":"127.0.0.1:59566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-06T05:52:05.350538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.023859Z","time spent":"325.877383ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":584,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-05-06T05:52:05.350065Z","caller":"traceutil/trace.go:171","msg":"trace[1429260100] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:24503; }","duration":"148.497293ms","start":"2026-05-06T05:52:05.201554Z","end":"2026-05-06T05:52:05.350051Z","steps":["trace[1429260100] 'agreement among raft nodes before linearized reading'  (duration: 148.37467ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:05.636935Z","caller":"traceutil/trace.go:171","msg":"trace[1160015476] transaction","detail":"{read_only:false; response_revision:24504; number_of_response:1; }","duration":"281.941535ms","start":"2026-05-06T05:52:05.354966Z","end":"2026-05-06T05:52:05.636907Z","steps":["trace[1160015476] 'process raft request'  (duration: 263.79886ms)","trace[1160015476] 'compare'  (duration: 17.863938ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:05.874887Z","caller":"traceutil/trace.go:171","msg":"trace[296699665] transaction","detail":"{read_only:false; response_revision:24506; number_of_response:1; }","duration":"513.412883ms","start":"2026-05-06T05:52:05.361453Z","end":"2026-05-06T05:52:05.874866Z","steps":["trace[296699665] 'process raft request'  (duration: 513.336121ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:05.875064Z","caller":"traceutil/trace.go:171","msg":"trace[118418207] linearizableReadLoop","detail":"{readStateIndex:25318; appliedIndex:25316; }","duration":"519.227411ms","start":"2026-05-06T05:52:05.355813Z","end":"2026-05-06T05:52:05.875041Z","steps":["trace[118418207] 'read index received'  (duration: 262.898995ms)","trace[118418207] 'applied index is now lower than readState.Index'  (duration: 256.324526ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:05.875119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.361445Z","time spent":"513.536436ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24484 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T05:52:05.87531Z","caller":"traceutil/trace.go:171","msg":"trace[370032599] transaction","detail":"{read_only:false; response_revision:24505; number_of_response:1; }","duration":"519.776786ms","start":"2026-05-06T05:52:05.355521Z","end":"2026-05-06T05:52:05.875298Z","steps":["trace[370032599] 'process raft request'  (duration: 461.487205ms)","trace[370032599] 'compare'  (duration: 57.4762ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:05.875393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.355504Z","time spent":"519.861768ms","remote":"127.0.0.1:33620","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:24485 > 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-05-06T05:52:05.875391Z","caller":"traceutil/trace.go:171","msg":"trace[595116816] transaction","detail":"{read_only:false; response_revision:24507; number_of_response:1; }","duration":"359.341907ms","start":"2026-05-06T05:52:05.516036Z","end":"2026-05-06T05:52:05.875378Z","steps":["trace[595116816] 'process raft request'  (duration: 358.792222ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.875495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.516009Z","time spent":"359.416339ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24447 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:05.875701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.886879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:52:05.875738Z","caller":"traceutil/trace.go:171","msg":"trace[231039101] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24507; }","duration":"519.939281ms","start":"2026-05-06T05:52:05.355788Z","end":"2026-05-06T05:52:05.875728Z","steps":["trace[231039101] 'agreement among raft nodes before linearized reading'  (duration: 519.812647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.87577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.355782Z","time spent":"519.981712ms","remote":"127.0.0.1:33532","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-05-06T05:52:05.87606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.849831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-16e49056-7197-496b-bb42-d73d3fc06da8\" ","response":"range_response_count:1 size:1451"}
{"level":"info","ts":"2026-05-06T05:52:05.876114Z","caller":"traceutil/trace.go:171","msg":"trace[1737288177] range","detail":"{range_begin:/registry/persistentvolumes/pvc-16e49056-7197-496b-bb42-d73d3fc06da8; range_end:; response_count:1; response_revision:24509; }","duration":"518.921692ms","start":"2026-05-06T05:52:05.357184Z","end":"2026-05-06T05:52:05.876105Z","steps":["trace[1737288177] 'agreement among raft nodes before linearized reading'  (duration: 518.759088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.876182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.357178Z","time spent":"518.997314ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1474,"request content":"key:\"/registry/persistentvolumes/pvc-16e49056-7197-496b-bb42-d73d3fc06da8\" "}
{"level":"info","ts":"2026-05-06T05:52:05.876466Z","caller":"traceutil/trace.go:171","msg":"trace[680330137] transaction","detail":"{read_only:false; response_revision:24508; number_of_response:1; }","duration":"204.934453ms","start":"2026-05-06T05:52:05.671515Z","end":"2026-05-06T05:52:05.876449Z","steps":["trace[680330137] 'process raft request'  (duration: 204.024009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:05.87698Z","caller":"traceutil/trace.go:171","msg":"trace[1291425131] transaction","detail":"{read_only:false; response_revision:24509; number_of_response:1; }","duration":"189.067029ms","start":"2026-05-06T05:52:05.687798Z","end":"2026-05-06T05:52:05.876865Z","steps":["trace[1291425131] 'process raft request'  (duration: 188.081403ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.877158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.004964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-06T05:52:05.877235Z","caller":"traceutil/trace.go:171","msg":"trace[1402222803] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:24509; }","duration":"516.100546ms","start":"2026-05-06T05:52:05.361121Z","end":"2026-05-06T05:52:05.877222Z","steps":["trace[1402222803] 'agreement among raft nodes before linearized reading'  (duration: 515.92615ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.877278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.361114Z","time spent":"516.154697ms","remote":"127.0.0.1:33688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":125,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T05:52:05.87736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.788757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-05-06T05:52:05.877385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.208419ms","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-05-06T05:52:05.877478Z","caller":"traceutil/trace.go:171","msg":"trace[1553266699] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24509; }","duration":"205.973382ms","start":"2026-05-06T05:52:05.671443Z","end":"2026-05-06T05:52:05.877416Z","steps":["trace[1553266699] 'agreement among raft nodes before linearized reading'  (duration: 205.699965ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:05.877544Z","caller":"traceutil/trace.go:171","msg":"trace[13697384] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:24509; }","duration":"320.436836ms","start":"2026-05-06T05:52:05.557075Z","end":"2026-05-06T05:52:05.877511Z","steps":["trace[13697384] 'agreement among raft nodes before linearized reading'  (duration: 320.093317ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:05.877608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:05.557061Z","time spent":"320.534249ms","remote":"127.0.0.1:40078","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":"info","ts":"2026-05-06T05:52:10.053855Z","caller":"traceutil/trace.go:171","msg":"trace[1403947957] transaction","detail":"{read_only:false; response_revision:24540; number_of_response:1; }","duration":"113.956139ms","start":"2026-05-06T05:52:09.939867Z","end":"2026-05-06T05:52:10.053823Z","steps":["trace[1403947957] 'process raft request'  (duration: 112.49394ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:10.299144Z","caller":"traceutil/trace.go:171","msg":"trace[461654484] transaction","detail":"{read_only:false; response_revision:24541; number_of_response:1; }","duration":"191.425154ms","start":"2026-05-06T05:52:10.107657Z","end":"2026-05-06T05:52:10.299082Z","steps":["trace[461654484] 'process raft request'  (duration: 188.000491ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:10.550376Z","caller":"traceutil/trace.go:171","msg":"trace[872602863] transaction","detail":"{read_only:false; response_revision:24542; number_of_response:1; }","duration":"210.31304ms","start":"2026-05-06T05:52:10.340038Z","end":"2026-05-06T05:52:10.550351Z","steps":["trace[872602863] 'process raft request'  (duration: 134.965813ms)","trace[872602863] 'compare'  (duration: 75.216413ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:11.177209Z","caller":"traceutil/trace.go:171","msg":"trace[877282349] linearizableReadLoop","detail":"{readStateIndex:25358; appliedIndex:25356; }","duration":"371.022795ms","start":"2026-05-06T05:52:10.806149Z","end":"2026-05-06T05:52:11.177172Z","steps":["trace[877282349] 'read index received'  (duration: 40.766213ms)","trace[877282349] 'applied index is now lower than readState.Index'  (duration: 330.255432ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:11.17736Z","caller":"traceutil/trace.go:171","msg":"trace[247729631] transaction","detail":"{read_only:false; response_revision:24544; number_of_response:1; }","duration":"371.486218ms","start":"2026-05-06T05:52:10.805862Z","end":"2026-05-06T05:52:11.177348Z","steps":["trace[247729631] 'process raft request'  (duration: 363.856911ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:11.17747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:10.805849Z","time spent":"371.53523ms","remote":"127.0.0.1:33620","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:24529 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:11.177619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.859753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-06T05:52:11.177612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.457619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:11.177652Z","caller":"traceutil/trace.go:171","msg":"trace[1080339002] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24544; }","duration":"174.932055ms","start":"2026-05-06T05:52:11.002709Z","end":"2026-05-06T05:52:11.177642Z","steps":["trace[1080339002] 'agreement among raft nodes before linearized reading'  (duration: 174.863463ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:11.177627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.612888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:11.17768Z","caller":"traceutil/trace.go:171","msg":"trace[697682304] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24544; }","duration":"371.581972ms","start":"2026-05-06T05:52:10.806081Z","end":"2026-05-06T05:52:11.177663Z","steps":["trace[697682304] 'agreement among raft nodes before linearized reading'  (duration: 371.452108ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:11.177712Z","caller":"traceutil/trace.go:171","msg":"trace[190932942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24544; }","duration":"173.737131ms","start":"2026-05-06T05:52:11.003954Z","end":"2026-05-06T05:52:11.177691Z","steps":["trace[190932942] 'agreement among raft nodes before linearized reading'  (duration: 173.606768ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:11.177735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:10.80606Z","time spent":"371.664534ms","remote":"127.0.0.1:32862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T05:52:11.177818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.058386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:52:11.178431Z","caller":"traceutil/trace.go:171","msg":"trace[1698245893] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24544; }","duration":"150.670923ms","start":"2026-05-06T05:52:11.027707Z","end":"2026-05-06T05:52:11.178378Z","steps":["trace[1698245893] 'agreement among raft nodes before linearized reading'  (duration: 149.908782ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:11.46311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.075508ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414390 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24530 > 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-05-06T05:52:11.463291Z","caller":"traceutil/trace.go:171","msg":"trace[1104263356] transaction","detail":"{read_only:false; response_revision:24545; number_of_response:1; }","duration":"265.836955ms","start":"2026-05-06T05:52:11.19743Z","end":"2026-05-06T05:52:11.463267Z","steps":["trace[1104263356] 'process raft request'  (duration: 116.519239ms)","trace[1104263356] 'compare'  (duration: 148.860793ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:11.463516Z","caller":"traceutil/trace.go:171","msg":"trace[329616438] linearizableReadLoop","detail":"{readStateIndex:25359; appliedIndex:25358; }","duration":"210.565077ms","start":"2026-05-06T05:52:11.252928Z","end":"2026-05-06T05:52:11.463493Z","steps":["trace[329616438] 'read index received'  (duration: 60.947283ms)","trace[329616438] 'applied index is now lower than readState.Index'  (duration: 149.615914ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:11.463641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.695011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:11.463679Z","caller":"traceutil/trace.go:171","msg":"trace[313334561] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24546; }","duration":"210.777093ms","start":"2026-05-06T05:52:11.252891Z","end":"2026-05-06T05:52:11.463668Z","steps":["trace[313334561] 'agreement among raft nodes before linearized reading'  (duration: 210.691881ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:11.529096Z","caller":"traceutil/trace.go:171","msg":"trace[963593226] transaction","detail":"{read_only:false; response_revision:24547; number_of_response:1; }","duration":"144.534065ms","start":"2026-05-06T05:52:11.384506Z","end":"2026-05-06T05:52:11.52904Z","steps":["trace[963593226] 'process raft request'  (duration: 144.313229ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.038699Z","caller":"traceutil/trace.go:171","msg":"trace[493297300] transaction","detail":"{read_only:false; response_revision:24548; number_of_response:1; }","duration":"128.610369ms","start":"2026-05-06T05:52:11.910022Z","end":"2026-05-06T05:52:12.038633Z","steps":["trace[493297300] 'process raft request'  (duration: 128.434085ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.190126Z","caller":"traceutil/trace.go:171","msg":"trace[860409236] transaction","detail":"{read_only:false; response_revision:24550; number_of_response:1; }","duration":"278.14756ms","start":"2026-05-06T05:52:11.911955Z","end":"2026-05-06T05:52:12.190102Z","steps":["trace[860409236] 'process raft request'  (duration: 278.024747ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.190359Z","caller":"traceutil/trace.go:171","msg":"trace[1551097730] linearizableReadLoop","detail":"{readStateIndex:25363; appliedIndex:25361; }","duration":"279.328443ms","start":"2026-05-06T05:52:11.911Z","end":"2026-05-06T05:52:12.190328Z","steps":["trace[1551097730] 'read index received'  (duration: 127.51639ms)","trace[1551097730] 'applied index is now lower than readState.Index'  (duration: 151.810673ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:12.190424Z","caller":"traceutil/trace.go:171","msg":"trace[716421507] transaction","detail":"{read_only:false; response_revision:24549; number_of_response:1; }","duration":"280.071583ms","start":"2026-05-06T05:52:11.910334Z","end":"2026-05-06T05:52:12.190406Z","steps":["trace[716421507] 'process raft request'  (duration: 279.406805ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.19057Z","caller":"traceutil/trace.go:171","msg":"trace[1653476803] transaction","detail":"{read_only:false; response_revision:24551; number_of_response:1; }","duration":"274.995144ms","start":"2026-05-06T05:52:11.915557Z","end":"2026-05-06T05:52:12.190553Z","steps":["trace[1653476803] 'process raft request'  (duration: 274.47146ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.191016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.992601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-06T05:52:12.191105Z","caller":"traceutil/trace.go:171","msg":"trace[1815382230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24551; }","duration":"280.132345ms","start":"2026-05-06T05:52:11.910954Z","end":"2026-05-06T05:52:12.191087Z","steps":["trace[1815382230] 'agreement among raft nodes before linearized reading'  (duration: 279.880478ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.203162Z","caller":"traceutil/trace.go:171","msg":"trace[965777867] transaction","detail":"{read_only:false; response_revision:24552; number_of_response:1; }","duration":"163.945755ms","start":"2026-05-06T05:52:12.039196Z","end":"2026-05-06T05:52:12.203141Z","steps":["trace[965777867] 'process raft request'  (duration: 163.76729ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.203201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.886612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-06T05:52:12.203253Z","caller":"traceutil/trace.go:171","msg":"trace[919217346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24552; }","duration":"285.960364ms","start":"2026-05-06T05:52:11.917276Z","end":"2026-05-06T05:52:12.203237Z","steps":["trace[919217346] 'agreement among raft nodes before linearized reading'  (duration: 285.81351ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.203261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.141748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:12.203314Z","caller":"traceutil/trace.go:171","msg":"trace[699447691] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24552; }","duration":"187.246781ms","start":"2026-05-06T05:52:12.016051Z","end":"2026-05-06T05:52:12.203298Z","steps":["trace[699447691] 'agreement among raft nodes before linearized reading'  (duration: 187.146108ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.203343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.439377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-06T05:52:12.203391Z","caller":"traceutil/trace.go:171","msg":"trace[207942898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24552; }","duration":"146.53376ms","start":"2026-05-06T05:52:12.056846Z","end":"2026-05-06T05:52:12.20338Z","steps":["trace[207942898] 'agreement among raft nodes before linearized reading'  (duration: 146.334105ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.611583Z","caller":"traceutil/trace.go:171","msg":"trace[1592710613] transaction","detail":"{read_only:false; response_revision:24554; number_of_response:1; }","duration":"404.405997ms","start":"2026-05-06T05:52:12.207146Z","end":"2026-05-06T05:52:12.611552Z","steps":["trace[1592710613] 'process raft request'  (duration: 404.093239ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.611754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:12.207128Z","time spent":"404.536291ms","remote":"127.0.0.1:33620","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:24539 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-06T05:52:12.612148Z","caller":"traceutil/trace.go:171","msg":"trace[1467681919] linearizableReadLoop","detail":"{readStateIndex:25369; appliedIndex:25366; }","duration":"394.458335ms","start":"2026-05-06T05:52:12.217671Z","end":"2026-05-06T05:52:12.612129Z","steps":["trace[1467681919] 'read index received'  (duration: 27.053799ms)","trace[1467681919] 'applied index is now lower than readState.Index'  (duration: 367.403636ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:12.612238Z","caller":"traceutil/trace.go:171","msg":"trace[1633824559] transaction","detail":"{read_only:false; response_revision:24555; number_of_response:1; }","duration":"396.749668ms","start":"2026-05-06T05:52:12.215481Z","end":"2026-05-06T05:52:12.612231Z","steps":["trace[1633824559] 'process raft request'  (duration: 395.962516ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.612329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:12.215473Z","time spent":"396.787079ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24540 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:12.612414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.711702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:12.612503Z","caller":"traceutil/trace.go:171","msg":"trace[1808298174] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24555; }","duration":"394.832876ms","start":"2026-05-06T05:52:12.217648Z","end":"2026-05-06T05:52:12.612481Z","steps":["trace[1808298174] 'agreement among raft nodes before linearized reading'  (duration: 394.639211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.612553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:12.217641Z","time spent":"394.901348ms","remote":"127.0.0.1:33544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-05-06T05:52:12.657817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.11126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:12.657888Z","caller":"traceutil/trace.go:171","msg":"trace[724637849] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24556; }","duration":"182.226223ms","start":"2026-05-06T05:52:12.475647Z","end":"2026-05-06T05:52:12.657874Z","steps":["trace[724637849] 'agreement among raft nodes before linearized reading'  (duration: 182.1226ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.657885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.273827ms","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-05-06T05:52:12.657806Z","caller":"traceutil/trace.go:171","msg":"trace[2137861183] transaction","detail":"{read_only:false; response_revision:24556; number_of_response:1; }","duration":"101.615123ms","start":"2026-05-06T05:52:12.556157Z","end":"2026-05-06T05:52:12.657773Z","steps":["trace[2137861183] 'process raft request'  (duration: 101.307475ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:12.657969Z","caller":"traceutil/trace.go:171","msg":"trace[202026118] 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:24556; }","duration":"406.396611ms","start":"2026-05-06T05:52:12.251549Z","end":"2026-05-06T05:52:12.657945Z","steps":["trace[202026118] 'agreement among raft nodes before linearized reading'  (duration: 406.110923ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:12.658022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:12.251528Z","time spent":"406.482344ms","remote":"127.0.0.1:33504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2106,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-05-06T05:52:12.930332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.45632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:12.93042Z","caller":"traceutil/trace.go:171","msg":"trace[1765822728] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24556; }","duration":"152.586514ms","start":"2026-05-06T05:52:12.777815Z","end":"2026-05-06T05:52:12.930401Z","steps":["trace[1765822728] 'count revisions from in-memory index tree'  (duration: 152.396269ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:13.065682Z","caller":"traceutil/trace.go:171","msg":"trace[1188504679] transaction","detail":"{read_only:false; response_revision:24557; number_of_response:1; }","duration":"130.839361ms","start":"2026-05-06T05:52:12.934804Z","end":"2026-05-06T05:52:13.065643Z","steps":["trace[1188504679] 'process raft request'  (duration: 130.609334ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:13.298884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.156218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-06T05:52:13.298968Z","caller":"traceutil/trace.go:171","msg":"trace[1747602866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24557; }","duration":"117.294741ms","start":"2026-05-06T05:52:13.181655Z","end":"2026-05-06T05:52:13.29895Z","steps":["trace[1747602866] 'range keys from in-memory index tree'  (duration: 116.966412ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:13.299156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.033952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-06T05:52:13.299223Z","caller":"traceutil/trace.go:171","msg":"trace[1792433911] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24557; }","duration":"144.144344ms","start":"2026-05-06T05:52:13.155061Z","end":"2026-05-06T05:52:13.299206Z","steps":["trace[1792433911] 'range keys from in-memory index tree'  (duration: 143.879246ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:13.696601Z","caller":"traceutil/trace.go:171","msg":"trace[1387220280] transaction","detail":"{read_only:false; response_revision:24560; number_of_response:1; }","duration":"225.68844ms","start":"2026-05-06T05:52:13.470895Z","end":"2026-05-06T05:52:13.696583Z","steps":["trace[1387220280] 'process raft request'  (duration: 225.584067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:13.708502Z","caller":"traceutil/trace.go:171","msg":"trace[950734868] transaction","detail":"{read_only:false; response_revision:24562; number_of_response:1; }","duration":"173.460925ms","start":"2026-05-06T05:52:13.53502Z","end":"2026-05-06T05:52:13.708481Z","steps":["trace[950734868] 'process raft request'  (duration: 173.425234ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:13.708703Z","caller":"traceutil/trace.go:171","msg":"trace[915684561] transaction","detail":"{read_only:false; response_revision:24561; number_of_response:1; }","duration":"237.559584ms","start":"2026-05-06T05:52:13.471122Z","end":"2026-05-06T05:52:13.708681Z","steps":["trace[915684561] 'process raft request'  (duration: 237.216325ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:14.134767Z","caller":"traceutil/trace.go:171","msg":"trace[1190824266] transaction","detail":"{read_only:false; response_revision:24563; number_of_response:1; }","duration":"236.637778ms","start":"2026-05-06T05:52:13.898107Z","end":"2026-05-06T05:52:14.134744Z","steps":["trace[1190824266] 'process raft request'  (duration: 236.462673ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:14.373873Z","caller":"traceutil/trace.go:171","msg":"trace[70603195] linearizableReadLoop","detail":"{readStateIndex:25379; appliedIndex:25378; }","duration":"236.826384ms","start":"2026-05-06T05:52:14.137018Z","end":"2026-05-06T05:52:14.373844Z","steps":["trace[70603195] 'read index received'  (duration: 203.919076ms)","trace[70603195] 'applied index is now lower than readState.Index'  (duration: 32.906178ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:14.374049Z","caller":"traceutil/trace.go:171","msg":"trace[340337741] transaction","detail":"{read_only:false; response_revision:24564; number_of_response:1; }","duration":"330.659244ms","start":"2026-05-06T05:52:14.043373Z","end":"2026-05-06T05:52:14.374032Z","steps":["trace[340337741] 'process raft request'  (duration: 297.5498ms)","trace[340337741] 'compare'  (duration: 32.776134ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:14.374178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.04335Z","time spent":"330.740687ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24548 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:14.37419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.158843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-05-06T05:52:14.374267Z","caller":"traceutil/trace.go:171","msg":"trace[1655275673] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24564; }","duration":"237.279126ms","start":"2026-05-06T05:52:14.136968Z","end":"2026-05-06T05:52:14.374247Z","steps":["trace[1655275673] 'agreement among raft nodes before linearized reading'  (duration: 237.07021ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:14.68486Z","caller":"traceutil/trace.go:171","msg":"trace[42161794] linearizableReadLoop","detail":"{readStateIndex:25381; appliedIndex:25379; }","duration":"310.856844ms","start":"2026-05-06T05:52:14.373984Z","end":"2026-05-06T05:52:14.684841Z","steps":["trace[42161794] 'read index received'  (duration: 310.704018ms)","trace[42161794] 'applied index is now lower than readState.Index'  (duration: 152.076µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:14.685099Z","caller":"traceutil/trace.go:171","msg":"trace[1833362855] transaction","detail":"{read_only:false; response_revision:24565; number_of_response:1; }","duration":"489.432577ms","start":"2026-05-06T05:52:14.195656Z","end":"2026-05-06T05:52:14.685088Z","steps":["trace[1833362855] 'process raft request'  (duration: 489.005045ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.685184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.195629Z","time spent":"489.491279ms","remote":"127.0.0.1:33620","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:24549 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:14.685223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.462088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-05-06T05:52:14.685296Z","caller":"traceutil/trace.go:171","msg":"trace[792600775] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:24566; }","duration":"367.569982ms","start":"2026-05-06T05:52:14.317707Z","end":"2026-05-06T05:52:14.685277Z","steps":["trace[792600775] 'agreement among raft nodes before linearized reading'  (duration: 367.357257ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.685343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.679711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-06T05:52:14.685348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.317688Z","time spent":"367.648534ms","remote":"127.0.0.1:33504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-06T05:52:14.685398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.216352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-06T05:52:14.685415Z","caller":"traceutil/trace.go:171","msg":"trace[1613802619] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24566; }","duration":"489.261643ms","start":"2026-05-06T05:52:14.196149Z","end":"2026-05-06T05:52:14.685411Z","steps":["trace[1613802619] 'agreement among raft nodes before linearized reading'  (duration: 489.220712ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.685428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.196135Z","time spent":"489.289694ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-06T05:52:14.685359Z","caller":"traceutil/trace.go:171","msg":"trace[1250914692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24566; }","duration":"435.734052ms","start":"2026-05-06T05:52:14.24962Z","end":"2026-05-06T05:52:14.685354Z","steps":["trace[1250914692] 'agreement among raft nodes before linearized reading'  (duration: 435.688971ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:14.685607Z","caller":"traceutil/trace.go:171","msg":"trace[474126674] transaction","detail":"{read_only:false; response_revision:24566; number_of_response:1; }","duration":"489.629453ms","start":"2026-05-06T05:52:14.195949Z","end":"2026-05-06T05:52:14.685578Z","steps":["trace[474126674] 'process raft request'  (duration: 488.864333ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.685614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.249599Z","time spent":"435.98038ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-06T05:52:14.685752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.195932Z","time spent":"489.742056ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24551 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:14.686761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.056938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:14.686824Z","caller":"traceutil/trace.go:171","msg":"trace[721098032] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:24566; }","duration":"367.15636ms","start":"2026-05-06T05:52:14.319651Z","end":"2026-05-06T05:52:14.686808Z","steps":["trace[721098032] 'agreement among raft nodes before linearized reading'  (duration: 366.249675ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.686867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.319626Z","time spent":"367.231312ms","remote":"127.0.0.1:58476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T05:52:14.927503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.622844ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414437 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24556 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:14.927587Z","caller":"traceutil/trace.go:171","msg":"trace[619372739] linearizableReadLoop","detail":"{readStateIndex:25382; appliedIndex:25381; }","duration":"242.648272ms","start":"2026-05-06T05:52:14.684926Z","end":"2026-05-06T05:52:14.927574Z","steps":["trace[619372739] 'read index received'  (duration: 85.879913ms)","trace[619372739] 'applied index is now lower than readState.Index'  (duration: 156.767139ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:14.927641Z","caller":"traceutil/trace.go:171","msg":"trace[1918599995] transaction","detail":"{read_only:false; response_revision:24567; number_of_response:1; }","duration":"263.47154ms","start":"2026-05-06T05:52:14.664159Z","end":"2026-05-06T05:52:14.927631Z","steps":["trace[1918599995] 'process raft request'  (duration: 106.64409ms)","trace[1918599995] 'compare'  (duration: 156.09804ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:14.927824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.155171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-06T05:52:14.927852Z","caller":"traceutil/trace.go:171","msg":"trace[402003714] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:24567; }","duration":"551.184542ms","start":"2026-05-06T05:52:14.37666Z","end":"2026-05-06T05:52:14.927845Z","steps":["trace[402003714] 'agreement among raft nodes before linearized reading'  (duration: 551.077659ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.927872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.376588Z","time spent":"551.278674ms","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "}
{"level":"warn","ts":"2026-05-06T05:52:14.92822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.295255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-06T05:52:14.928274Z","caller":"traceutil/trace.go:171","msg":"trace[69240312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24567; }","duration":"311.408479ms","start":"2026-05-06T05:52:14.616855Z","end":"2026-05-06T05:52:14.928263Z","steps":["trace[69240312] 'agreement among raft nodes before linearized reading'  (duration: 311.234114ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.928305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.616823Z","time spent":"311.47642ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-06T05:52:14.929339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.815257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-06T05:52:14.929436Z","caller":"traceutil/trace.go:171","msg":"trace[517267983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24567; }","duration":"312.950001ms","start":"2026-05-06T05:52:14.616465Z","end":"2026-05-06T05:52:14.929415Z","steps":["trace[517267983] 'agreement among raft nodes before linearized reading'  (duration: 311.240964ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.929486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:14.61645Z","time spent":"313.023343ms","remote":"127.0.0.1:33620","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":"info","ts":"2026-05-06T05:52:14.930331Z","caller":"traceutil/trace.go:171","msg":"trace[2042737039] transaction","detail":"{read_only:false; response_revision:24569; number_of_response:1; }","duration":"240.012379ms","start":"2026-05-06T05:52:14.6903Z","end":"2026-05-06T05:52:14.930312Z","steps":["trace[2042737039] 'process raft request'  (duration: 239.901356ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.930379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.102787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5554995e-e4a0-4f46-9916-1f05da568b80\" ","response":"range_response_count:1 size:1323"}
{"level":"info","ts":"2026-05-06T05:52:14.930393Z","caller":"traceutil/trace.go:171","msg":"trace[871751376] transaction","detail":"{read_only:false; response_revision:24568; number_of_response:1; }","duration":"240.508954ms","start":"2026-05-06T05:52:14.689856Z","end":"2026-05-06T05:52:14.930365Z","steps":["trace[871751376] 'process raft request'  (duration: 240.202145ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.930472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.586802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7749"}
{"level":"info","ts":"2026-05-06T05:52:14.930502Z","caller":"traceutil/trace.go:171","msg":"trace[283078336] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:24569; }","duration":"219.618353ms","start":"2026-05-06T05:52:14.710878Z","end":"2026-05-06T05:52:14.930496Z","steps":["trace[283078336] 'agreement among raft nodes before linearized reading'  (duration: 219.537951ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:14.930421Z","caller":"traceutil/trace.go:171","msg":"trace[431481833] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5554995e-e4a0-4f46-9916-1f05da568b80; range_end:; response_count:1; response_revision:24569; }","duration":"242.1941ms","start":"2026-05-06T05:52:14.688214Z","end":"2026-05-06T05:52:14.930409Z","steps":["trace[431481833] 'agreement among raft nodes before linearized reading'  (duration: 242.053186ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:14.930492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.953821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:14.930593Z","caller":"traceutil/trace.go:171","msg":"trace[1513034104] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:24569; }","duration":"180.091835ms","start":"2026-05-06T05:52:14.750477Z","end":"2026-05-06T05:52:14.930569Z","steps":["trace[1513034104] 'agreement among raft nodes before linearized reading'  (duration: 179.924141ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:15.125525Z","caller":"traceutil/trace.go:171","msg":"trace[1056123757] transaction","detail":"{read_only:false; response_revision:24571; number_of_response:1; }","duration":"188.896116ms","start":"2026-05-06T05:52:14.936598Z","end":"2026-05-06T05:52:15.125494Z","steps":["trace[1056123757] 'process raft request'  (duration: 147.969118ms)","trace[1056123757] 'compare'  (duration: 40.777634ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:15.125663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.301256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:15.125722Z","caller":"traceutil/trace.go:171","msg":"trace[2700574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24571; }","duration":"123.402748ms","start":"2026-05-06T05:52:15.002306Z","end":"2026-05-06T05:52:15.125709Z","steps":["trace[2700574] 'agreement among raft nodes before linearized reading'  (duration: 123.270465ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:15.125527Z","caller":"traceutil/trace.go:171","msg":"trace[561363449] linearizableReadLoop","detail":"{readStateIndex:25386; appliedIndex:25385; }","duration":"123.125821ms","start":"2026-05-06T05:52:15.002344Z","end":"2026-05-06T05:52:15.12547Z","steps":["trace[561363449] 'read index received'  (duration: 82.150262ms)","trace[561363449] 'applied index is now lower than readState.Index'  (duration: 40.974619ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:15.12629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.944038ms","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:6"}
{"level":"info","ts":"2026-05-06T05:52:15.126347Z","caller":"traceutil/trace.go:171","msg":"trace[1918944937] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:24571; }","duration":"122.02472ms","start":"2026-05-06T05:52:15.004306Z","end":"2026-05-06T05:52:15.126331Z","steps":["trace[1918944937] 'agreement among raft nodes before linearized reading'  (duration: 121.938148ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:15.412629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.100029ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414449 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24557 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:15.4127Z","caller":"traceutil/trace.go:171","msg":"trace[1473512529] linearizableReadLoop","detail":"{readStateIndex:25387; appliedIndex:25386; }","duration":"217.66875ms","start":"2026-05-06T05:52:15.195019Z","end":"2026-05-06T05:52:15.412688Z","steps":["trace[1473512529] 'read index received'  (duration: 46.433857ms)","trace[1473512529] 'applied index is now lower than readState.Index'  (duration: 171.234243ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:15.412834Z","caller":"traceutil/trace.go:171","msg":"trace[2063052359] transaction","detail":"{read_only:false; response_revision:24572; number_of_response:1; }","duration":"279.24322ms","start":"2026-05-06T05:52:15.133584Z","end":"2026-05-06T05:52:15.412827Z","steps":["trace[2063052359] 'process raft request'  (duration: 107.889184ms)","trace[2063052359] 'compare'  (duration: 170.798931ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:15.413031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.020139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-06T05:52:15.41305Z","caller":"traceutil/trace.go:171","msg":"trace[1353035250] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:24572; }","duration":"218.086531ms","start":"2026-05-06T05:52:15.194959Z","end":"2026-05-06T05:52:15.413045Z","steps":["trace[1353035250] 'agreement among raft nodes before linearized reading'  (duration: 217.970448ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:24.919251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.367145ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414770 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24626 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:24.919552Z","caller":"traceutil/trace.go:171","msg":"trace[1190024317] transaction","detail":"{read_only:false; response_revision:24699; number_of_response:1; }","duration":"176.210589ms","start":"2026-05-06T05:52:24.743316Z","end":"2026-05-06T05:52:24.919527Z","steps":["trace[1190024317] 'process raft request'  (duration: 33.33394ms)","trace[1190024317] 'compare'  (duration: 141.981995ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:24.919592Z","caller":"traceutil/trace.go:171","msg":"trace[1224458566] linearizableReadLoop","detail":"{readStateIndex:25517; appliedIndex:25515; }","duration":"143.509247ms","start":"2026-05-06T05:52:24.776068Z","end":"2026-05-06T05:52:24.919577Z","steps":["trace[1224458566] 'read index received'  (duration: 544.285µs)","trace[1224458566] 'applied index is now lower than readState.Index'  (duration: 142.964162ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:24.919694Z","caller":"traceutil/trace.go:171","msg":"trace[977441317] transaction","detail":"{read_only:false; response_revision:24700; number_of_response:1; }","duration":"174.973805ms","start":"2026-05-06T05:52:24.744656Z","end":"2026-05-06T05:52:24.91963Z","steps":["trace[977441317] 'process raft request'  (duration: 174.810321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:24.919785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.184115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-05-06T05:52:24.919815Z","caller":"traceutil/trace.go:171","msg":"trace[995471145] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760; range_end:; response_count:1; response_revision:24700; }","duration":"100.249507ms","start":"2026-05-06T05:52:24.819556Z","end":"2026-05-06T05:52:24.919805Z","steps":["trace[995471145] 'agreement among raft nodes before linearized reading'  (duration: 100.138464ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:24.920152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.082552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-05-06T05:52:24.920175Z","caller":"traceutil/trace.go:171","msg":"trace[1566042869] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760; range_end:; response_count:1; response_revision:24700; }","duration":"144.138663ms","start":"2026-05-06T05:52:24.776027Z","end":"2026-05-06T05:52:24.920166Z","steps":["trace[1566042869] 'agreement among raft nodes before linearized reading'  (duration: 143.64377ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:25.237751Z","caller":"traceutil/trace.go:171","msg":"trace[927416039] linearizableReadLoop","detail":"{readStateIndex:25518; appliedIndex:25517; }","duration":"277.505004ms","start":"2026-05-06T05:52:24.960219Z","end":"2026-05-06T05:52:25.237724Z","steps":["trace[927416039] 'read index received'  (duration: 187.095186ms)","trace[927416039] 'applied index is now lower than readState.Index'  (duration: 90.408778ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:25.238021Z","caller":"traceutil/trace.go:171","msg":"trace[1080577628] transaction","detail":"{read_only:false; response_revision:24701; number_of_response:1; }","duration":"313.408313ms","start":"2026-05-06T05:52:24.924585Z","end":"2026-05-06T05:52:25.237993Z","steps":["trace[1080577628] 'process raft request'  (duration: 222.712677ms)","trace[1080577628] 'compare'  (duration: 90.285625ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:25.238077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.832502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:25.238157Z","caller":"traceutil/trace.go:171","msg":"trace[2025811320] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:24701; }","duration":"277.937426ms","start":"2026-05-06T05:52:24.960195Z","end":"2026-05-06T05:52:25.238133Z","steps":["trace[2025811320] 'agreement among raft nodes before linearized reading'  (duration: 277.793862ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.238242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:24.92457Z","time spent":"313.527717ms","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" mod_revision:24684 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" value_size:3645 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:25.251892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.292686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-06T05:52:25.251988Z","caller":"traceutil/trace.go:171","msg":"trace[1796467337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24702; }","duration":"278.402599ms","start":"2026-05-06T05:52:24.973559Z","end":"2026-05-06T05:52:25.251962Z","steps":["trace[1796467337] 'agreement among raft nodes before linearized reading'  (duration: 278.174873ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:25.252412Z","caller":"traceutil/trace.go:171","msg":"trace[1343700110] transaction","detail":"{read_only:false; response_revision:24702; number_of_response:1; }","duration":"285.519383ms","start":"2026-05-06T05:52:24.966878Z","end":"2026-05-06T05:52:25.252397Z","steps":["trace[1343700110] 'process raft request'  (duration: 284.720142ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.252795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.696801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-06T05:52:25.25284Z","caller":"traceutil/trace.go:171","msg":"trace[259237908] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24702; }","duration":"202.790065ms","start":"2026-05-06T05:52:25.050039Z","end":"2026-05-06T05:52:25.252829Z","steps":["trace[259237908] 'agreement among raft nodes before linearized reading'  (duration: 202.719973ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.253017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.192194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:25.253045Z","caller":"traceutil/trace.go:171","msg":"trace[766505233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24702; }","duration":"248.235075ms","start":"2026-05-06T05:52:25.004802Z","end":"2026-05-06T05:52:25.253037Z","steps":["trace[766505233] 'agreement among raft nodes before linearized reading'  (duration: 248.181414ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.253249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.629096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-06T05:52:25.253299Z","caller":"traceutil/trace.go:171","msg":"trace[1201979172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24702; }","duration":"248.702248ms","start":"2026-05-06T05:52:25.004584Z","end":"2026-05-06T05:52:25.253286Z","steps":["trace[1201979172] 'agreement among raft nodes before linearized reading'  (duration: 248.584815ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.253429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.526134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-06T05:52:25.253449Z","caller":"traceutil/trace.go:171","msg":"trace[470001870] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24702; }","duration":"266.555715ms","start":"2026-05-06T05:52:24.986885Z","end":"2026-05-06T05:52:25.253441Z","steps":["trace[470001870] 'agreement among raft nodes before linearized reading'  (duration: 266.497934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.534936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.371389ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414780 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24629 > 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-05-06T05:52:25.535021Z","caller":"traceutil/trace.go:171","msg":"trace[1507638140] transaction","detail":"{read_only:false; response_revision:24703; number_of_response:1; }","duration":"278.226734ms","start":"2026-05-06T05:52:25.256779Z","end":"2026-05-06T05:52:25.535006Z","steps":["trace[1507638140] 'process raft request'  (duration: 136.720532ms)","trace[1507638140] 'compare'  (duration: 141.07297ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:25.602253Z","caller":"traceutil/trace.go:171","msg":"trace[88659749] linearizableReadLoop","detail":"{readStateIndex:25523; appliedIndex:25520; }","duration":"161.844548ms","start":"2026-05-06T05:52:25.440385Z","end":"2026-05-06T05:52:25.60223Z","steps":["trace[88659749] 'read index received'  (duration: 161.54464ms)","trace[88659749] 'applied index is now lower than readState.Index'  (duration: 299.028µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:25.602308Z","caller":"traceutil/trace.go:171","msg":"trace[1014526466] transaction","detail":"{read_only:false; response_revision:24705; number_of_response:1; }","duration":"344.841972ms","start":"2026-05-06T05:52:25.257422Z","end":"2026-05-06T05:52:25.602264Z","steps":["trace[1014526466] 'process raft request'  (duration: 344.724719ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:25.602377Z","caller":"traceutil/trace.go:171","msg":"trace[2043005795] transaction","detail":"{read_only:false; response_revision:24706; number_of_response:1; }","duration":"343.721142ms","start":"2026-05-06T05:52:25.258644Z","end":"2026-05-06T05:52:25.602365Z","steps":["trace[2043005795] 'process raft request'  (duration: 343.544087ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.60246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:25.257415Z","time spent":"344.965705ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":416,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24631 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:366 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:25.602739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.342191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-06T05:52:25.602733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.671335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-06T05:52:25.602792Z","caller":"traceutil/trace.go:171","msg":"trace[2046482061] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24706; }","duration":"162.423713ms","start":"2026-05-06T05:52:25.440352Z","end":"2026-05-06T05:52:25.602776Z","steps":["trace[2046482061] 'agreement among raft nodes before linearized reading'  (duration: 162.33606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:25.602807Z","caller":"traceutil/trace.go:171","msg":"trace[1749139551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24706; }","duration":"138.815959ms","start":"2026-05-06T05:52:25.463974Z","end":"2026-05-06T05:52:25.60279Z","steps":["trace[1749139551] 'agreement among raft nodes before linearized reading'  (duration: 138.555292ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.603068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.684422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-05-06T05:52:25.602491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:25.258621Z","time spent":"343.785123ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24630 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T05:52:25.603115Z","caller":"traceutil/trace.go:171","msg":"trace[742265239] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24706; }","duration":"128.763224ms","start":"2026-05-06T05:52:25.474335Z","end":"2026-05-06T05:52:25.603098Z","steps":["trace[742265239] 'agreement among raft nodes before linearized reading'  (duration: 128.641231ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:25.603496Z","caller":"traceutil/trace.go:171","msg":"trace[353745966] transaction","detail":"{read_only:false; response_revision:24704; number_of_response:1; }","duration":"346.190037ms","start":"2026-05-06T05:52:25.257291Z","end":"2026-05-06T05:52:25.603481Z","steps":["trace[353745966] 'process raft request'  (duration: 344.695227ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:25.603736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:25.257279Z","time spent":"346.412153ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24632 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-06T05:52:25.712387Z","caller":"traceutil/trace.go:171","msg":"trace[471720774] transaction","detail":"{read_only:false; response_revision:24707; number_of_response:1; }","duration":"105.484159ms","start":"2026-05-06T05:52:25.606875Z","end":"2026-05-06T05:52:25.712359Z","steps":["trace[471720774] 'process raft request'  (duration: 91.672352ms)","trace[471720774] 'compare'  (duration: 13.613952ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:25.712716Z","caller":"traceutil/trace.go:171","msg":"trace[1375023749] transaction","detail":"{read_only:false; response_revision:24708; number_of_response:1; }","duration":"104.873422ms","start":"2026-05-06T05:52:25.60783Z","end":"2026-05-06T05:52:25.712703Z","steps":["trace[1375023749] 'process raft request'  (duration: 104.486122ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:26.043203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.438794ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414791 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24672 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:26.043539Z","caller":"traceutil/trace.go:171","msg":"trace[2036294087] transaction","detail":"{read_only:false; response_revision:24711; number_of_response:1; }","duration":"296.78672ms","start":"2026-05-06T05:52:25.74673Z","end":"2026-05-06T05:52:26.043517Z","steps":["trace[2036294087] 'process raft request'  (duration: 296.746118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:26.043701Z","caller":"traceutil/trace.go:171","msg":"trace[994894720] transaction","detail":"{read_only:false; response_revision:24709; number_of_response:1; }","duration":"306.248117ms","start":"2026-05-06T05:52:25.737413Z","end":"2026-05-06T05:52:26.043661Z","steps":["trace[994894720] 'process raft request'  (duration: 143.263069ms)","trace[994894720] 'compare'  (duration: 162.162416ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:26.04375Z","caller":"traceutil/trace.go:171","msg":"trace[2028155139] linearizableReadLoop","detail":"{readStateIndex:25526; appliedIndex:25525; }","duration":"301.96098ms","start":"2026-05-06T05:52:25.741765Z","end":"2026-05-06T05:52:26.043726Z","steps":["trace[2028155139] 'read index received'  (duration: 138.90396ms)","trace[2028155139] 'applied index is now lower than readState.Index'  (duration: 163.05564ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:26.043995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:25.737402Z","time spent":"306.498524ms","remote":"127.0.0.1:33620","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:24672 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-06T05:52:26.043777Z","caller":"traceutil/trace.go:171","msg":"trace[1196031233] transaction","detail":"{read_only:false; response_revision:24710; number_of_response:1; }","duration":"297.313264ms","start":"2026-05-06T05:52:25.746432Z","end":"2026-05-06T05:52:26.043745Z","steps":["trace[1196031233] 'process raft request'  (duration: 296.949774ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:26.044284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.048813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:26.044374Z","caller":"traceutil/trace.go:171","msg":"trace[2007613318] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:24711; }","duration":"276.171697ms","start":"2026-05-06T05:52:25.768185Z","end":"2026-05-06T05:52:26.044357Z","steps":["trace[2007613318] 'agreement among raft nodes before linearized reading'  (duration: 276.050793ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:26.04441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.620762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" ","response":"range_response_count:1 size:3763"}
{"level":"warn","ts":"2026-05-06T05:52:26.044427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.63352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"}
{"level":"info","ts":"2026-05-06T05:52:26.044506Z","caller":"traceutil/trace.go:171","msg":"trace[1887234535] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760; range_end:; response_count:1; response_revision:24711; }","duration":"120.692374ms","start":"2026-05-06T05:52:25.923776Z","end":"2026-05-06T05:52:26.044468Z","steps":["trace[1887234535] 'agreement among raft nodes before linearized reading'  (duration: 120.492748ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:26.044535Z","caller":"traceutil/trace.go:171","msg":"trace[1509754164] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:24711; }","duration":"302.776394ms","start":"2026-05-06T05:52:25.74173Z","end":"2026-05-06T05:52:26.044507Z","steps":["trace[1509754164] 'agreement among raft nodes before linearized reading'  (duration: 302.067644ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:26.044616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:25.741715Z","time spent":"302.884537ms","remote":"127.0.0.1:33544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":1281,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" "}
{"level":"warn","ts":"2026-05-06T05:52:26.33159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.471375ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414798 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18ace417cd3deb01\" mod_revision:24688 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18ace417cd3deb01\" value_size:647 lease:9114896400103637939 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18ace417cd3deb01\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:26.331668Z","caller":"traceutil/trace.go:171","msg":"trace[1751309759] linearizableReadLoop","detail":"{readStateIndex:25529; appliedIndex:25528; }","duration":"277.940356ms","start":"2026-05-06T05:52:26.053715Z","end":"2026-05-06T05:52:26.331655Z","steps":["trace[1751309759] 'read index received'  (duration: 141.291516ms)","trace[1751309759] 'applied index is now lower than readState.Index'  (duration: 136.64755ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:26.331753Z","caller":"traceutil/trace.go:171","msg":"trace[1020249858] transaction","detail":"{read_only:false; response_revision:24712; number_of_response:1; }","duration":"280.513856ms","start":"2026-05-06T05:52:26.051196Z","end":"2026-05-06T05:52:26.33171Z","steps":["trace[1020249858] 'process raft request'  (duration: 143.847356ms)","trace[1020249858] 'compare'  (duration: 136.161917ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:26.331902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.183622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9602"}
{"level":"info","ts":"2026-05-06T05:52:26.331928Z","caller":"traceutil/trace.go:171","msg":"trace[1195110503] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24712; }","duration":"278.223653ms","start":"2026-05-06T05:52:26.053698Z","end":"2026-05-06T05:52:26.331921Z","steps":["trace[1195110503] 'agreement among raft nodes before linearized reading'  (duration: 277.990437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:26.727475Z","caller":"traceutil/trace.go:171","msg":"trace[1289926193] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"320.980349ms","start":"2026-05-06T05:52:26.406462Z","end":"2026-05-06T05:52:26.727442Z","steps":["trace[1289926193] 'process raft request'  (duration: 248.46639ms)","trace[1289926193] 'compare'  (duration: 72.372505ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:26.727641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:26.406443Z","time spent":"321.117313ms","remote":"127.0.0.1:59622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":729,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18ace417cea930d1\" mod_revision:24690 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18ace417cea930d1\" value_size:652 lease:9114896400103637939 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18ace417cea930d1\" > >"}
{"level":"info","ts":"2026-05-06T05:52:26.802047Z","caller":"traceutil/trace.go:171","msg":"trace[2066768708] transaction","detail":"{read_only:false; response_revision:24715; number_of_response:1; }","duration":"361.872636ms","start":"2026-05-06T05:52:26.440158Z","end":"2026-05-06T05:52:26.802031Z","steps":["trace[2066768708] 'process raft request'  (duration: 361.731462ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:26.802113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.900537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:26.802142Z","caller":"traceutil/trace.go:171","msg":"trace[1067152387] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24715; }","duration":"154.974959ms","start":"2026-05-06T05:52:26.64716Z","end":"2026-05-06T05:52:26.802135Z","steps":["trace[1067152387] 'agreement among raft nodes before linearized reading'  (duration: 154.911557ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:26.802144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:26.440131Z","time spent":"361.957929ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24695 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-06T05:52:26.802027Z","caller":"traceutil/trace.go:171","msg":"trace[1583867588] linearizableReadLoop","detail":"{readStateIndex:25532; appliedIndex:25530; }","duration":"154.795884ms","start":"2026-05-06T05:52:26.647204Z","end":"2026-05-06T05:52:26.802Z","steps":["trace[1583867588] 'read index received'  (duration: 7.7117ms)","trace[1583867588] 'applied index is now lower than readState.Index'  (duration: 147.083514ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:28.298862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.556426ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958414846 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24710 > 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-05-06T05:52:28.299128Z","caller":"traceutil/trace.go:171","msg":"trace[2077904611] linearizableReadLoop","detail":"{readStateIndex:25546; appliedIndex:25543; }","duration":"243.759312ms","start":"2026-05-06T05:52:28.055346Z","end":"2026-05-06T05:52:28.299106Z","steps":["trace[2077904611] 'read index received'  (duration: 72.996142ms)","trace[2077904611] 'applied index is now lower than readState.Index'  (duration: 170.7618ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:28.299403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.05381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760\" ","response":"range_response_count:1 size:3949"}
{"level":"info","ts":"2026-05-06T05:52:28.299428Z","caller":"traceutil/trace.go:171","msg":"trace[1016167020] transaction","detail":"{read_only:false; response_revision:24728; number_of_response:1; }","duration":"249.031146ms","start":"2026-05-06T05:52:28.050375Z","end":"2026-05-06T05:52:28.299406Z","steps":["trace[1016167020] 'process raft request'  (duration: 100.806501ms)","trace[1016167020] 'compare'  (duration: 147.249998ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:28.299455Z","caller":"traceutil/trace.go:171","msg":"trace[74218467] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-52de02e5-3f74-41fd-94df-ea688bdd9760; range_end:; response_count:1; response_revision:24729; }","duration":"244.124253ms","start":"2026-05-06T05:52:28.055315Z","end":"2026-05-06T05:52:28.299439Z","steps":["trace[74218467] 'agreement among raft nodes before linearized reading'  (duration: 243.870586ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:28.299542Z","caller":"traceutil/trace.go:171","msg":"trace[319322893] transaction","detail":"{read_only:false; response_revision:24729; number_of_response:1; }","duration":"248.887553ms","start":"2026-05-06T05:52:28.050639Z","end":"2026-05-06T05:52:28.299527Z","steps":["trace[319322893] 'process raft request'  (duration: 248.349367ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:59.395675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.90552ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958415506 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24980 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:52:59.395941Z","caller":"traceutil/trace.go:171","msg":"trace[1379423372] transaction","detail":"{read_only:false; response_revision:24995; number_of_response:1; }","duration":"484.829311ms","start":"2026-05-06T05:52:58.911074Z","end":"2026-05-06T05:52:59.395903Z","steps":["trace[1379423372] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/capi-system/controller-leader-election-capi; req_size:518; } (duration: 478.742426ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:59.39608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:58.911052Z","time spent":"484.958015ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24980 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-06T05:52:59.396418Z","caller":"traceutil/trace.go:171","msg":"trace[2131088755] linearizableReadLoop","detail":"{readStateIndex:25819; appliedIndex:25818; }","duration":"455.892813ms","start":"2026-05-06T05:52:58.940516Z","end":"2026-05-06T05:52:59.396409Z","steps":["trace[2131088755] 'read index received'  (duration: 37.631µs)","trace[2131088755] 'applied index is now lower than readState.Index'  (duration: 455.853562ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:59.55747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.701603ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958415507 > lease_revoke:<id:7e7e9dfbacaa0959>","response":"size:29"}
{"level":"warn","ts":"2026-05-06T05:52:59.557564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.021611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:59.55763Z","caller":"traceutil/trace.go:171","msg":"trace[2038310856] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:24995; }","duration":"617.139804ms","start":"2026-05-06T05:52:58.940471Z","end":"2026-05-06T05:52:59.557611Z","steps":["trace[2038310856] 'agreement among raft nodes before linearized reading'  (duration: 456.003846ms)","trace[2038310856] 'count revisions from in-memory index tree'  (duration: 161.016415ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:52:59.557672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:58.940453Z","time spent":"617.207755ms","remote":"127.0.0.1:40066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "}
{"level":"info","ts":"2026-05-06T05:52:59.55798Z","caller":"traceutil/trace.go:171","msg":"trace[1679223607] linearizableReadLoop","detail":"{readStateIndex:25823; appliedIndex:25819; }","duration":"161.523348ms","start":"2026-05-06T05:52:59.396434Z","end":"2026-05-06T05:52:59.557957Z","steps":["trace[1679223607] 'read index received'  (duration: 73.401µs)","trace[1679223607] 'applied index is now lower than readState.Index'  (duration: 161.448817ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:52:59.558041Z","caller":"traceutil/trace.go:171","msg":"trace[257631116] transaction","detail":"{read_only:false; response_revision:24996; number_of_response:1; }","duration":"524.603568ms","start":"2026-05-06T05:52:59.033398Z","end":"2026-05-06T05:52:59.558002Z","steps":["trace[257631116] 'process raft request'  (duration: 524.150746ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:59.55812Z","caller":"traceutil/trace.go:171","msg":"trace[1137198067] transaction","detail":"{read_only:false; response_revision:24997; number_of_response:1; }","duration":"523.704383ms","start":"2026-05-06T05:52:59.034393Z","end":"2026-05-06T05:52:59.558098Z","steps":["trace[1137198067] 'process raft request'  (duration: 523.411645ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:59.55822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:59.033384Z","time spent":"524.743602ms","remote":"127.0.0.1:33620","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:24982 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:59.558235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:59.034385Z","time spent":"523.767114ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24981 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-06T05:52:59.558253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.978099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-06T05:52:59.558271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.5714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:59.55831Z","caller":"traceutil/trace.go:171","msg":"trace[47321455] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:24998; }","duration":"138.672185ms","start":"2026-05-06T05:52:59.419618Z","end":"2026-05-06T05:52:59.558291Z","steps":["trace[47321455] 'agreement among raft nodes before linearized reading'  (duration: 138.580503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:59.558346Z","caller":"traceutil/trace.go:171","msg":"trace[1961263448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24998; }","duration":"541.685683ms","start":"2026-05-06T05:52:59.016642Z","end":"2026-05-06T05:52:59.558327Z","steps":["trace[1961263448] 'agreement among raft nodes before linearized reading'  (duration: 541.522619ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:52:59.55834Z","caller":"traceutil/trace.go:171","msg":"trace[473687707] transaction","detail":"{read_only:false; response_revision:24998; number_of_response:1; }","duration":"183.56015ms","start":"2026-05-06T05:52:59.374729Z","end":"2026-05-06T05:52:59.558289Z","steps":["trace[473687707] 'process raft request'  (duration: 183.167999ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:52:59.558388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:52:59.016627Z","time spent":"541.753135ms","remote":"127.0.0.1:59556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-06T05:52:59.558402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.909421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:52:59.558444Z","caller":"traceutil/trace.go:171","msg":"trace[116792865] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24998; }","duration":"212.976583ms","start":"2026-05-06T05:52:59.345457Z","end":"2026-05-06T05:52:59.558434Z","steps":["trace[116792865] 'agreement among raft nodes before linearized reading'  (duration: 212.900581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:00.006306Z","caller":"traceutil/trace.go:171","msg":"trace[1558935645] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"243.915947ms","start":"2026-05-06T05:52:59.762373Z","end":"2026-05-06T05:53:00.006289Z","steps":["trace[1558935645] 'process raft request'  (duration: 243.763993ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:00.029674Z","caller":"traceutil/trace.go:171","msg":"trace[1370176265] linearizableReadLoop","detail":"{readStateIndex:25827; appliedIndex:25823; }","duration":"202.26311ms","start":"2026-05-06T05:52:59.827394Z","end":"2026-05-06T05:53:00.029657Z","steps":["trace[1370176265] 'read index received'  (duration: 178.861052ms)","trace[1370176265] 'applied index is now lower than readState.Index'  (duration: 23.400808ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:00.029724Z","caller":"traceutil/trace.go:171","msg":"trace[1786880453] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"266.73942ms","start":"2026-05-06T05:52:59.762942Z","end":"2026-05-06T05:53:00.029682Z","steps":["trace[1786880453] 'process raft request'  (duration: 266.443292ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:00.029822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.412974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:53:00.029871Z","caller":"traceutil/trace.go:171","msg":"trace[1362728106] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:25002; }","duration":"202.517536ms","start":"2026-05-06T05:52:59.827338Z","end":"2026-05-06T05:53:00.029855Z","steps":["trace[1362728106] 'agreement among raft nodes before linearized reading'  (duration: 202.430884ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:00.029968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.593359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-06T05:53:00.030022Z","caller":"traceutil/trace.go:171","msg":"trace[2095488180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25002; }","duration":"176.695273ms","start":"2026-05-06T05:52:59.853312Z","end":"2026-05-06T05:53:00.030008Z","steps":["trace[2095488180] 'agreement among raft nodes before linearized reading'  (duration: 176.553629ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:00.030159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.912368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-06T05:53:00.030233Z","caller":"traceutil/trace.go:171","msg":"trace[1189545608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25002; }","duration":"165.99837ms","start":"2026-05-06T05:52:59.864213Z","end":"2026-05-06T05:53:00.030211Z","steps":["trace[1189545608] 'agreement among raft nodes before linearized reading'  (duration: 165.743233ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:00.029467Z","caller":"traceutil/trace.go:171","msg":"trace[1765505809] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"267.044878ms","start":"2026-05-06T05:52:59.762375Z","end":"2026-05-06T05:53:00.02942Z","steps":["trace[1765505809] 'process raft request'  (duration: 266.854773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:00.030457Z","caller":"traceutil/trace.go:171","msg":"trace[1027108702] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"262.410372ms","start":"2026-05-06T05:52:59.767326Z","end":"2026-05-06T05:53:00.029736Z","steps":["trace[1027108702] 'process raft request'  (duration: 262.269578ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:00.235341Z","caller":"traceutil/trace.go:171","msg":"trace[818433208] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"201.478169ms","start":"2026-05-06T05:53:00.033836Z","end":"2026-05-06T05:53:00.235315Z","steps":["trace[818433208] 'process raft request'  (duration: 134.103419ms)","trace[818433208] 'compare'  (duration: 67.185764ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:00.23534Z","caller":"traceutil/trace.go:171","msg":"trace[923407917] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"200.915334ms","start":"2026-05-06T05:53:00.034399Z","end":"2026-05-06T05:53:00.235315Z","steps":["trace[923407917] 'process raft request'  (duration: 200.862672ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:00.662638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.741763ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958415531 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24993 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:53:00.662946Z","caller":"traceutil/trace.go:171","msg":"trace[2116595872] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"254.464005ms","start":"2026-05-06T05:53:00.408454Z","end":"2026-05-06T05:53:00.662918Z","steps":["trace[2116595872] 'process raft request'  (duration: 136.359992ms)","trace[2116595872] 'compare'  (duration: 117.62096ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:01.132331Z","caller":"traceutil/trace.go:171","msg":"trace[1166521855] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"144.563856ms","start":"2026-05-06T05:53:00.987741Z","end":"2026-05-06T05:53:01.132304Z","steps":["trace[1166521855] 'process raft request'  (duration: 144.3532ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:01.406008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.241927ms","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-05-06T05:53:01.406108Z","caller":"traceutil/trace.go:171","msg":"trace[712665587] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25008; }","duration":"162.399302ms","start":"2026-05-06T05:53:01.243684Z","end":"2026-05-06T05:53:01.406083Z","steps":["trace[712665587] 'count revisions from in-memory index tree'  (duration: 162.114454ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:01.621454Z","caller":"traceutil/trace.go:171","msg":"trace[875998782] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"210.676259ms","start":"2026-05-06T05:53:01.410754Z","end":"2026-05-06T05:53:01.62143Z","steps":["trace[875998782] 'process raft request'  (duration: 210.516535ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:01.874748Z","caller":"traceutil/trace.go:171","msg":"trace[1982840885] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"312.564361ms","start":"2026-05-06T05:53:01.562162Z","end":"2026-05-06T05:53:01.874726Z","steps":["trace[1982840885] 'process raft request'  (duration: 216.970432ms)","trace[1982840885] 'compare'  (duration: 94.962472ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:01.874859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:01.562143Z","time spent":"312.659763ms","remote":"127.0.0.1:33620","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:24996 > 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":"info","ts":"2026-05-06T05:53:01.874988Z","caller":"traceutil/trace.go:171","msg":"trace[1021861446] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"312.122449ms","start":"2026-05-06T05:53:01.562858Z","end":"2026-05-06T05:53:01.874981Z","steps":["trace[1021861446] 'process raft request'  (duration: 311.520302ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:01.875027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:01.562851Z","time spent":"312.156389ms","remote":"127.0.0.1:33620","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:24997 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-06T05:53:01.875077Z","caller":"traceutil/trace.go:171","msg":"trace[381261817] transaction","detail":"{read_only:false; response_revision:25012; number_of_response:1; }","duration":"311.873771ms","start":"2026-05-06T05:53:01.563198Z","end":"2026-05-06T05:53:01.875071Z","steps":["trace[381261817] 'process raft request'  (duration: 311.265805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:01.875112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:01.563173Z","time spent":"311.919943ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24998 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-06T05:53:01.875165Z","caller":"traceutil/trace.go:171","msg":"trace[1738807679] transaction","detail":"{read_only:false; response_revision:25013; number_of_response:1; }","duration":"270.670998ms","start":"2026-05-06T05:53:01.604489Z","end":"2026-05-06T05:53:01.87516Z","steps":["trace[1738807679] 'process raft request'  (duration: 270.00614ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.105426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.185662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:53:02.105503Z","caller":"traceutil/trace.go:171","msg":"trace[1245000655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25013; }","duration":"101.311515ms","start":"2026-05-06T05:53:02.004172Z","end":"2026-05-06T05:53:02.105483Z","steps":["trace[1245000655] 'range keys from in-memory index tree'  (duration: 101.11439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:02.290871Z","caller":"traceutil/trace.go:171","msg":"trace[1300563492] transaction","detail":"{read_only:false; response_revision:25015; number_of_response:1; }","duration":"180.28384ms","start":"2026-05-06T05:53:02.110571Z","end":"2026-05-06T05:53:02.290855Z","steps":["trace[1300563492] 'process raft request'  (duration: 169.558277ms)","trace[1300563492] 'compare'  (duration: 10.386664ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:02.291019Z","caller":"traceutil/trace.go:171","msg":"trace[906158720] linearizableReadLoop","detail":"{readStateIndex:25842; appliedIndex:25838; }","duration":"133.397279ms","start":"2026-05-06T05:53:02.157615Z","end":"2026-05-06T05:53:02.291013Z","steps":["trace[906158720] 'read index received'  (duration: 16.260383ms)","trace[906158720] 'applied index is now lower than readState.Index'  (duration: 117.136186ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:02.291239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.614796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-05-06T05:53:02.291257Z","caller":"traceutil/trace.go:171","msg":"trace[1038741891] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25017; }","duration":"133.644907ms","start":"2026-05-06T05:53:02.157607Z","end":"2026-05-06T05:53:02.291252Z","steps":["trace[1038741891] 'agreement among raft nodes before linearized reading'  (duration: 133.559925ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:02.291165Z","caller":"traceutil/trace.go:171","msg":"trace[1396700834] transaction","detail":"{read_only:false; response_revision:25017; number_of_response:1; }","duration":"174.228495ms","start":"2026-05-06T05:53:02.116915Z","end":"2026-05-06T05:53:02.291143Z","steps":["trace[1396700834] 'process raft request'  (duration: 174.071161ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:02.291357Z","caller":"traceutil/trace.go:171","msg":"trace[121277781] transaction","detail":"{read_only:false; response_revision:25016; number_of_response:1; }","duration":"179.860418ms","start":"2026-05-06T05:53:02.111487Z","end":"2026-05-06T05:53:02.291347Z","steps":["trace[121277781] 'process raft request'  (duration: 179.339074ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:02.66551Z","caller":"traceutil/trace.go:171","msg":"trace[916648037] transaction","detail":"{read_only:false; response_revision:25019; number_of_response:1; }","duration":"369.293778ms","start":"2026-05-06T05:53:02.296177Z","end":"2026-05-06T05:53:02.665471Z","steps":["trace[916648037] 'process raft request'  (duration: 291.67944ms)","trace[916648037] 'compare'  (duration: 77.257869ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:02.665722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.296162Z","time spent":"369.445333ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24899 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-05-06T05:53:02.840976Z","caller":"traceutil/trace.go:171","msg":"trace[656719951] transaction","detail":"{read_only:false; response_revision:25020; number_of_response:1; }","duration":"526.856709ms","start":"2026-05-06T05:53:02.314085Z","end":"2026-05-06T05:53:02.840942Z","steps":["trace[656719951] 'process raft request'  (duration: 489.071627ms)","trace[656719951] 'compare'  (duration: 37.520524ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:02.841204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.314061Z","time spent":"527.030824ms","remote":"127.0.0.1:59622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/barbican-api-5cfc98df68-dxcqh.18ace24ccb4d456b\" mod_revision:21611 > success:<request_put:<key:\"/registry/events/openstack/barbican-api-5cfc98df68-dxcqh.18ace24ccb4d456b\" value_size:1029 lease:9114896400103639515 >> failure:<request_range:<key:\"/registry/events/openstack/barbican-api-5cfc98df68-dxcqh.18ace24ccb4d456b\" > >"}
{"level":"info","ts":"2026-05-06T05:53:02.841454Z","caller":"traceutil/trace.go:171","msg":"trace[1502694930] transaction","detail":"{read_only:false; response_revision:25021; number_of_response:1; }","duration":"525.233845ms","start":"2026-05-06T05:53:02.316193Z","end":"2026-05-06T05:53:02.841426Z","steps":["trace[1502694930] 'process raft request'  (duration: 524.663159ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.841664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.31618Z","time spent":"525.382249ms","remote":"127.0.0.1:33620","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:25003 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-06T05:53:02.841985Z","caller":"traceutil/trace.go:171","msg":"trace[150191549] transaction","detail":"{read_only:false; response_revision:25022; number_of_response:1; }","duration":"522.341135ms","start":"2026-05-06T05:53:02.319631Z","end":"2026-05-06T05:53:02.841972Z","steps":["trace[150191549] 'process raft request'  (duration: 521.684678ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.842054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.319607Z","time spent":"522.413677ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25004 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-06T05:53:02.842241Z","caller":"traceutil/trace.go:171","msg":"trace[1432923319] transaction","detail":"{read_only:false; response_revision:25023; number_of_response:1; }","duration":"512.294861ms","start":"2026-05-06T05:53:02.329936Z","end":"2026-05-06T05:53:02.842231Z","steps":["trace[1432923319] 'process raft request'  (duration: 511.980493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.842296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.32992Z","time spent":"512.349703ms","remote":"127.0.0.1:33620","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:25005 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-06T05:53:02.842424Z","caller":"traceutil/trace.go:171","msg":"trace[707695266] linearizableReadLoop","detail":"{readStateIndex:25845; appliedIndex:25843; }","duration":"527.222828ms","start":"2026-05-06T05:53:02.315188Z","end":"2026-05-06T05:53:02.842411Z","steps":["trace[707695266] 'read index received'  (duration: 272.749083ms)","trace[707695266] 'applied index is now lower than readState.Index'  (duration: 254.472365ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:02.842493Z","caller":"traceutil/trace.go:171","msg":"trace[1307461567] transaction","detail":"{read_only:false; response_revision:25024; number_of_response:1; }","duration":"363.020607ms","start":"2026-05-06T05:53:02.479464Z","end":"2026-05-06T05:53:02.842485Z","steps":["trace[1307461567] 'process raft request'  (duration: 362.725989ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.842544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.479444Z","time spent":"363.068668ms","remote":"127.0.0.1:33620","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:25006 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-05-06T05:53:02.842796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.603718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-54d68fca-7bec-401d-b2d2-7bf66ed271ea\" ","response":"range_response_count:1 size:1320"}
{"level":"info","ts":"2026-05-06T05:53:02.842832Z","caller":"traceutil/trace.go:171","msg":"trace[1213934846] range","detail":"{range_begin:/registry/persistentvolumes/pvc-54d68fca-7bec-401d-b2d2-7bf66ed271ea; range_end:; response_count:1; response_revision:25024; }","duration":"527.639479ms","start":"2026-05-06T05:53:02.315183Z","end":"2026-05-06T05:53:02.842823Z","steps":["trace[1213934846] 'agreement among raft nodes before linearized reading'  (duration: 527.439634ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.842855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.315153Z","time spent":"527.697061ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1343,"request content":"key:\"/registry/persistentvolumes/pvc-54d68fca-7bec-401d-b2d2-7bf66ed271ea\" "}
{"level":"warn","ts":"2026-05-06T05:53:02.845539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.43036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:53:02.845628Z","caller":"traceutil/trace.go:171","msg":"trace[1167516802] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25025; }","duration":"318.605794ms","start":"2026-05-06T05:53:02.527001Z","end":"2026-05-06T05:53:02.845607Z","steps":["trace[1167516802] 'agreement among raft nodes before linearized reading'  (duration: 318.339587ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:02.845671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:02.52698Z","time spent":"318.680977ms","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-06T05:53:02.846022Z","caller":"traceutil/trace.go:171","msg":"trace[518320655] transaction","detail":"{read_only:false; response_revision:25025; number_of_response:1; }","duration":"171.662195ms","start":"2026-05-06T05:53:02.674346Z","end":"2026-05-06T05:53:02.846009Z","steps":["trace[518320655] 'process raft request'  (duration: 170.865474ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:03.735264Z","caller":"traceutil/trace.go:171","msg":"trace[662439167] transaction","detail":"{read_only:false; response_revision:25026; number_of_response:1; }","duration":"107.857595ms","start":"2026-05-06T05:53:03.627386Z","end":"2026-05-06T05:53:03.735244Z","steps":["trace[662439167] 'process raft request'  (duration: 107.712991ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:04.359462Z","caller":"traceutil/trace.go:171","msg":"trace[1630390472] linearizableReadLoop","detail":"{readStateIndex:25857; appliedIndex:25856; }","duration":"124.289943ms","start":"2026-05-06T05:53:04.235149Z","end":"2026-05-06T05:53:04.359439Z","steps":["trace[1630390472] 'read index received'  (duration: 124.090878ms)","trace[1630390472] 'applied index is now lower than readState.Index'  (duration: 198.425µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:04.35969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.503659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-06T05:53:04.359743Z","caller":"traceutil/trace.go:171","msg":"trace[379422162] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"177.67697ms","start":"2026-05-06T05:53:04.181836Z","end":"2026-05-06T05:53:04.359513Z","steps":["trace[379422162] 'process raft request'  (duration: 177.454294ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:04.359787Z","caller":"traceutil/trace.go:171","msg":"trace[1906654476] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:25031; }","duration":"124.640723ms","start":"2026-05-06T05:53:04.235115Z","end":"2026-05-06T05:53:04.359756Z","steps":["trace[1906654476] 'agreement among raft nodes before linearized reading'  (duration: 124.448567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:05.057871Z","caller":"traceutil/trace.go:171","msg":"trace[1581616938] transaction","detail":"{read_only:false; response_revision:25038; number_of_response:1; }","duration":"207.298078ms","start":"2026-05-06T05:53:04.850553Z","end":"2026-05-06T05:53:05.057851Z","steps":["trace[1581616938] 'process raft request'  (duration: 207.258027ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:05.057948Z","caller":"traceutil/trace.go:171","msg":"trace[897291652] transaction","detail":"{read_only:false; response_revision:25037; number_of_response:1; }","duration":"207.888484ms","start":"2026-05-06T05:53:04.850043Z","end":"2026-05-06T05:53:05.057932Z","steps":["trace[897291652] 'process raft request'  (duration: 207.71882ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:05.057923Z","caller":"traceutil/trace.go:171","msg":"trace[1764856021] transaction","detail":"{read_only:false; response_revision:25036; number_of_response:1; }","duration":"207.867293ms","start":"2026-05-06T05:53:04.850022Z","end":"2026-05-06T05:53:05.05789Z","steps":["trace[1764856021] 'process raft request'  (duration: 207.596256ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:05.127092Z","caller":"traceutil/trace.go:171","msg":"trace[1680333117] linearizableReadLoop","detail":"{readStateIndex:25865; appliedIndex:25861; }","duration":"121.792164ms","start":"2026-05-06T05:53:05.005279Z","end":"2026-05-06T05:53:05.127071Z","steps":["trace[1680333117] 'read index received'  (duration: 52.430091ms)","trace[1680333117] 'applied index is now lower than readState.Index'  (duration: 69.360813ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:05.127273Z","caller":"traceutil/trace.go:171","msg":"trace[1590693650] transaction","detail":"{read_only:false; response_revision:25039; number_of_response:1; }","duration":"230.592545ms","start":"2026-05-06T05:53:04.896562Z","end":"2026-05-06T05:53:05.127154Z","steps":["trace[1590693650] 'process raft request'  (duration: 230.386339ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:05.127333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.012131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:53:05.127454Z","caller":"traceutil/trace.go:171","msg":"trace[253848515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25039; }","duration":"122.201886ms","start":"2026-05-06T05:53:05.005225Z","end":"2026-05-06T05:53:05.127427Z","steps":["trace[253848515] 'agreement among raft nodes before linearized reading'  (duration: 121.963099ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:05.88583Z","caller":"traceutil/trace.go:171","msg":"trace[1550133872] transaction","detail":"{read_only:false; response_revision:25041; number_of_response:1; }","duration":"145.374698ms","start":"2026-05-06T05:53:05.740424Z","end":"2026-05-06T05:53:05.885799Z","steps":["trace[1550133872] 'process raft request'  (duration: 74.389929ms)","trace[1550133872] 'compare'  (duration: 70.485314ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:06.090967Z","caller":"traceutil/trace.go:171","msg":"trace[920163018] transaction","detail":"{read_only:false; response_revision:25042; number_of_response:1; }","duration":"158.064025ms","start":"2026-05-06T05:53:05.93288Z","end":"2026-05-06T05:53:06.090944Z","steps":["trace[920163018] 'process raft request'  (duration: 157.89946ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:06.131473Z","caller":"traceutil/trace.go:171","msg":"trace[1853553612] transaction","detail":"{read_only:false; response_revision:25043; number_of_response:1; }","duration":"198.489108ms","start":"2026-05-06T05:53:05.932944Z","end":"2026-05-06T05:53:06.131433Z","steps":["trace[1853553612] 'process raft request'  (duration: 198.144538ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:06.131499Z","caller":"traceutil/trace.go:171","msg":"trace[565191147] transaction","detail":"{read_only:false; response_revision:25045; number_of_response:1; }","duration":"143.732862ms","start":"2026-05-06T05:53:05.987732Z","end":"2026-05-06T05:53:06.131465Z","steps":["trace[565191147] 'process raft request'  (duration: 143.604759ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:06.131583Z","caller":"traceutil/trace.go:171","msg":"trace[956634891] transaction","detail":"{read_only:false; response_revision:25044; number_of_response:1; }","duration":"196.376609ms","start":"2026-05-06T05:53:05.935197Z","end":"2026-05-06T05:53:06.131573Z","steps":["trace[956634891] 'process raft request'  (duration: 196.079311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:06.646619Z","caller":"traceutil/trace.go:171","msg":"trace[1117059503] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"230.698356ms","start":"2026-05-06T05:53:06.415893Z","end":"2026-05-06T05:53:06.646591Z","steps":["trace[1117059503] 'process raft request'  (duration: 134.44155ms)","trace[1117059503] 'compare'  (duration: 95.66133ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:06.646868Z","caller":"traceutil/trace.go:171","msg":"trace[1166819870] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"230.83968ms","start":"2026-05-06T05:53:06.416001Z","end":"2026-05-06T05:53:06.64684Z","steps":["trace[1166819870] 'process raft request'  (duration: 230.500321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:06.647194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.043966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-06T05:53:06.647241Z","caller":"traceutil/trace.go:171","msg":"trace[1115842370] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:25049; }","duration":"175.107268ms","start":"2026-05-06T05:53:06.472122Z","end":"2026-05-06T05:53:06.64723Z","steps":["trace[1115842370] 'agreement among raft nodes before linearized reading'  (duration: 174.963234ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:06.647268Z","caller":"traceutil/trace.go:171","msg":"trace[462240810] linearizableReadLoop","detail":"{readStateIndex:25875; appliedIndex:25872; }","duration":"174.640736ms","start":"2026-05-06T05:53:06.472139Z","end":"2026-05-06T05:53:06.64678Z","steps":["trace[462240810] 'read index received'  (duration: 11.265118ms)","trace[462240810] 'applied index is now lower than readState.Index'  (duration: 163.374398ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:07.304505Z","caller":"traceutil/trace.go:171","msg":"trace[1430207661] transaction","detail":"{read_only:false; response_revision:25052; number_of_response:1; }","duration":"240.710459ms","start":"2026-05-06T05:53:07.063773Z","end":"2026-05-06T05:53:07.304484Z","steps":["trace[1430207661] 'process raft request'  (duration: 211.06081ms)","trace[1430207661] 'compare'  (duration: 29.289479ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:07.304532Z","caller":"traceutil/trace.go:171","msg":"trace[1074914835] linearizableReadLoop","detail":"{readStateIndex:25878; appliedIndex:25876; }","duration":"227.384285ms","start":"2026-05-06T05:53:07.077131Z","end":"2026-05-06T05:53:07.304516Z","steps":["trace[1074914835] 'read index received'  (duration: 57.156649ms)","trace[1074914835] 'applied index is now lower than readState.Index'  (duration: 170.226746ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:07.304639Z","caller":"traceutil/trace.go:171","msg":"trace[546854712] transaction","detail":"{read_only:false; response_revision:25053; number_of_response:1; }","duration":"224.213069ms","start":"2026-05-06T05:53:07.080413Z","end":"2026-05-06T05:53:07.304626Z","steps":["trace[546854712] 'process raft request'  (duration: 223.992593ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:07.30496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.812127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:53:07.305022Z","caller":"traceutil/trace.go:171","msg":"trace[212484398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25053; }","duration":"227.92229ms","start":"2026-05-06T05:53:07.077083Z","end":"2026-05-06T05:53:07.305005Z","steps":["trace[212484398] 'agreement among raft nodes before linearized reading'  (duration: 227.802537ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:07.305069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.742524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-06T05:53:07.305173Z","caller":"traceutil/trace.go:171","msg":"trace[468847107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25053; }","duration":"172.910958ms","start":"2026-05-06T05:53:07.132234Z","end":"2026-05-06T05:53:07.305145Z","steps":["trace[468847107] 'agreement among raft nodes before linearized reading'  (duration: 172.61291ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:07.465692Z","caller":"traceutil/trace.go:171","msg":"trace[854424467] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"155.046922ms","start":"2026-05-06T05:53:07.310568Z","end":"2026-05-06T05:53:07.465615Z","steps":["trace[854424467] 'process raft request'  (duration: 95.605489ms)","trace[854424467] 'compare'  (duration: 59.246777ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:07.466289Z","caller":"traceutil/trace.go:171","msg":"trace[268294668] transaction","detail":"{read_only:false; response_revision:25055; number_of_response:1; }","duration":"148.827882ms","start":"2026-05-06T05:53:07.31743Z","end":"2026-05-06T05:53:07.466258Z","steps":["trace[268294668] 'process raft request'  (duration: 148.636226ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:22.386966Z","caller":"traceutil/trace.go:171","msg":"trace[1654315380] transaction","detail":"{read_only:false; response_revision:25164; number_of_response:1; }","duration":"125.472064ms","start":"2026-05-06T05:53:22.261469Z","end":"2026-05-06T05:53:22.386941Z","steps":["trace[1654315380] 'process raft request'  (duration: 108.272975ms)","trace[1654315380] 'compare'  (duration: 16.902451ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:22.430004Z","caller":"traceutil/trace.go:171","msg":"trace[926543118] transaction","detail":"{read_only:false; response_revision:25165; number_of_response:1; }","duration":"167.766479ms","start":"2026-05-06T05:53:22.262192Z","end":"2026-05-06T05:53:22.429958Z","steps":["trace[926543118] 'process raft request'  (duration: 167.42515ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:27.711016Z","caller":"traceutil/trace.go:171","msg":"trace[590505172] transaction","detail":"{read_only:false; response_revision:25212; number_of_response:1; }","duration":"123.51481ms","start":"2026-05-06T05:53:27.587473Z","end":"2026-05-06T05:53:27.710987Z","steps":["trace[590505172] 'process raft request'  (duration: 123.308255ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T05:53:28.35142Z","caller":"traceutil/trace.go:171","msg":"trace[601910657] transaction","detail":"{read_only:false; response_revision:25214; number_of_response:1; }","duration":"110.187307ms","start":"2026-05-06T05:53:28.241208Z","end":"2026-05-06T05:53:28.351395Z","steps":["trace[601910657] 'process raft request'  (duration: 110.014872ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:28.742082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.180285ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958416027 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25201 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-06T05:53:28.742257Z","caller":"traceutil/trace.go:171","msg":"trace[91025024] transaction","detail":"{read_only:false; response_revision:25215; number_of_response:1; }","duration":"338.875578ms","start":"2026-05-06T05:53:28.403333Z","end":"2026-05-06T05:53:28.742209Z","steps":["trace[91025024] 'process raft request'  (duration: 76.469036ms)","trace[91025024] 'compare'  (duration: 261.842526ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:28.742312Z","caller":"traceutil/trace.go:171","msg":"trace[287098863] linearizableReadLoop","detail":"{readStateIndex:26045; appliedIndex:26044; }","duration":"333.359187ms","start":"2026-05-06T05:53:28.408932Z","end":"2026-05-06T05:53:28.742291Z","steps":["trace[287098863] 'read index received'  (duration: 70.937815ms)","trace[287098863] 'applied index is now lower than readState.Index'  (duration: 262.420182ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:28.74251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:28.403307Z","time spent":"339.045233ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25201 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-06T05:53:28.743014Z","caller":"traceutil/trace.go:171","msg":"trace[754723291] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"295.742612ms","start":"2026-05-06T05:53:28.44723Z","end":"2026-05-06T05:53:28.742973Z","steps":["trace[754723291] 'process raft request'  (duration: 294.963781ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:28.743113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.16852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-06T05:53:28.743167Z","caller":"traceutil/trace.go:171","msg":"trace[159258344] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25216; }","duration":"334.258563ms","start":"2026-05-06T05:53:28.40889Z","end":"2026-05-06T05:53:28.743149Z","steps":["trace[159258344] 'agreement among raft nodes before linearized reading'  (duration: 333.491042ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:28.74321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:28.408855Z","time spent":"334.346025ms","remote":"127.0.0.1:33532","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-05-06T05:53:28.744505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.739747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-06T05:53:28.744587Z","caller":"traceutil/trace.go:171","msg":"trace[237637457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25217; }","duration":"219.887231ms","start":"2026-05-06T05:53:28.524682Z","end":"2026-05-06T05:53:28.744569Z","steps":["trace[237637457] 'agreement among raft nodes before linearized reading'  (duration: 219.662735ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:28.744918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.112348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-06T05:53:28.745058Z","caller":"traceutil/trace.go:171","msg":"trace[1294140130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25217; }","duration":"168.286943ms","start":"2026-05-06T05:53:28.57675Z","end":"2026-05-06T05:53:28.745037Z","steps":["trace[1294140130] 'agreement among raft nodes before linearized reading'  (duration: 168.035126ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:28.744935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.062978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-06T05:53:28.745183Z","caller":"traceutil/trace.go:171","msg":"trace[1739330499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25217; }","duration":"149.338046ms","start":"2026-05-06T05:53:28.595825Z","end":"2026-05-06T05:53:28.745163Z","steps":["trace[1739330499] 'agreement among raft nodes before linearized reading'  (duration: 149.052567ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:29.05563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.224891ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18338268436958416034 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25204 > 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-05-06T05:53:29.055728Z","caller":"traceutil/trace.go:171","msg":"trace[731143681] linearizableReadLoop","detail":"{readStateIndex:26049; appliedIndex:26047; }","duration":"306.407672ms","start":"2026-05-06T05:53:28.749305Z","end":"2026-05-06T05:53:29.055712Z","steps":["trace[731143681] 'read index received'  (duration: 69.158848ms)","trace[731143681] 'applied index is now lower than readState.Index'  (duration: 237.247354ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:53:29.055838Z","caller":"traceutil/trace.go:171","msg":"trace[624361423] transaction","detail":"{read_only:false; response_revision:25219; number_of_response:1; }","duration":"306.72027ms","start":"2026-05-06T05:53:28.749087Z","end":"2026-05-06T05:53:29.055808Z","steps":["trace[624361423] 'process raft request'  (duration: 160.232162ms)","trace[624361423] 'compare'  (duration: 146.018625ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T05:53:29.055941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.619349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18367"}
{"level":"info","ts":"2026-05-06T05:53:29.055998Z","caller":"traceutil/trace.go:171","msg":"trace[884572213] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25219; }","duration":"306.709171ms","start":"2026-05-06T05:53:28.749276Z","end":"2026-05-06T05:53:29.055985Z","steps":["trace[884572213] 'agreement among raft nodes before linearized reading'  (duration: 306.520215ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:29.056003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:28.749078Z","time spent":"306.833045ms","remote":"127.0.0.1:33620","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:25204 > 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-05-06T05:53:29.056038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:28.749267Z","time spent":"306.763563ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18390,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-05-06T05:53:29.060073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.697898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-06T05:53:29.060152Z","caller":"traceutil/trace.go:171","msg":"trace[932841458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25220; }","duration":"307.80055ms","start":"2026-05-06T05:53:28.752335Z","end":"2026-05-06T05:53:29.060136Z","steps":["trace[932841458] 'agreement among raft nodes before linearized reading'  (duration: 307.588605ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:29.060193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:28.752326Z","time spent":"307.857652ms","remote":"127.0.0.1:33620","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":"warn","ts":"2026-05-06T05:53:29.060663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.245156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-06T05:53:29.060712Z","caller":"traceutil/trace.go:171","msg":"trace[612294247] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25220; }","duration":"303.332678ms","start":"2026-05-06T05:53:28.757363Z","end":"2026-05-06T05:53:29.060696Z","steps":["trace[612294247] 'agreement among raft nodes before linearized reading'  (duration: 303.129612ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T05:53:29.060782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:53:28.757354Z","time spent":"303.414981ms","remote":"127.0.0.1:33620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-06T05:54:50.561813Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23173}
{"level":"info","ts":"2026-05-06T05:54:50.690811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23173,"took":"124.855161ms","hash":2189688155,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":36016128,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-06T05:54:50.690863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2189688155,"revision":23173,"compact-revision":20022}
{"level":"info","ts":"2026-05-06T05:54:53.71691Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006943.wal"}
{"level":"info","ts":"2026-05-06T05:56:53.190343Z","caller":"traceutil/trace.go:171","msg":"trace[1210258160] transaction","detail":"{read_only:false; response_revision:27344; number_of_response:1; }","duration":"108.010952ms","start":"2026-05-06T05:56:53.082307Z","end":"2026-05-06T05:56:53.190318Z","steps":["trace[1210258160] 'process raft request'  (duration: 56.516254ms)","trace[1210258160] 'compare'  (duration: 51.381175ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T05:59:50.567953Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26049}
{"level":"info","ts":"2026-05-06T05:59:50.696573Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26049,"took":"123.470233ms","hash":3119386920,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":36253696,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-06T05:59:50.696633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3119386920,"revision":26049,"compact-revision":23173}
{"level":"info","ts":"2026-05-06T06:00:29.112517Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2b5783e11defe7e","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-06T06:00:29.116836Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-06T06:00:29.116913Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-06T06:04:50.575285Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28684}
{"level":"info","ts":"2026-05-06T06:04:50.713731Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28684,"took":"134.071924ms","hash":3959929402,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":31117312,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-06T06:04:50.71382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3959929402,"revision":28684,"compact-revision":26049}
{"level":"info","ts":"2026-05-06T06:09:50.581393Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30972}
{"level":"info","ts":"2026-05-06T06:09:50.704623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30972,"took":"117.748426ms","hash":2521535898,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":31518720,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-06T06:09:50.70472Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2521535898,"revision":30972,"compact-revision":28684}
{"level":"info","ts":"2026-05-06T06:14:50.589475Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33270}
{"level":"info","ts":"2026-05-06T06:14:50.734972Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33270,"took":"141.387986ms","hash":2067445565,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":32407552,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-06T06:14:50.735055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2067445565,"revision":33270,"compact-revision":30972}
{"level":"info","ts":"2026-05-06T06:17:47.023017Z","caller":"traceutil/trace.go:171","msg":"trace[1307253315] transaction","detail":"{read_only:false; response_revision:36890; number_of_response:1; }","duration":"114.516168ms","start":"2026-05-06T06:17:46.908475Z","end":"2026-05-06T06:17:47.022991Z","steps":["trace[1307253315] 'process raft request'  (duration: 114.386135ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T06:17:47.023932Z","caller":"traceutil/trace.go:171","msg":"trace[1817257812] linearizableReadLoop","detail":"{readStateIndex:38045; appliedIndex:38044; }","duration":"104.870425ms","start":"2026-05-06T06:17:46.919031Z","end":"2026-05-06T06:17:47.023902Z","steps":["trace[1817257812] 'read index received'  (duration: 104.138595ms)","trace[1817257812] 'applied index is now lower than readState.Index'  (duration: 726.78µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T06:17:47.024247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.182373ms","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-05-06T06:17:47.0243Z","caller":"traceutil/trace.go:171","msg":"trace[1241143896] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:36891; }","duration":"105.317317ms","start":"2026-05-06T06:17:46.918969Z","end":"2026-05-06T06:17:47.024287Z","steps":["trace[1241143896] 'agreement among raft nodes before linearized reading'  (duration: 105.200494ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T06:17:47.024446Z","caller":"traceutil/trace.go:171","msg":"trace[1191688631] transaction","detail":"{read_only:false; response_revision:36891; number_of_response:1; }","duration":"106.264453ms","start":"2026-05-06T06:17:46.918157Z","end":"2026-05-06T06:17:47.024422Z","steps":["trace[1191688631] 'process raft request'  (duration: 105.551674ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T06:19:50.5962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35564}
{"level":"info","ts":"2026-05-06T06:19:50.734847Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35564,"took":"135.400811ms","hash":578501755,"current-db-size-bytes":61067264,"current-db-size":"61 MB","current-db-size-in-use-bytes":31903744,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-06T06:19:50.734896Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":578501755,"revision":35564,"compact-revision":33270}
{"level":"info","ts":"2026-05-06T06:21:54.231675Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2b5783e11defe7e","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-06T06:21:54.236576Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-06T06:21:54.236668Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}