{"level":"warn","ts":"2026-05-09T16:54:29.683396Z","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-09T16:54:29.683487Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-09T16:54:29.683574Z","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-09T16:54:29.683595Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]}
{"level":"info","ts":"2026-05-09T16:54:29.683623Z","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-09T16:54:29.684397Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]}
{"level":"info","ts":"2026-05-09T16:54:29.684511Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-09T16:54:29.688693Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.475895ms"}
{"level":"info","ts":"2026-05-09T16:54:29.699933Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"}
{"level":"info","ts":"2026-05-09T16:54:29.699996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-09T16:54:29.700018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"}
{"level":"info","ts":"2026-05-09T16:54:29.700035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-09T16:54:29.70005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"}
{"level":"info","ts":"2026-05-09T16:54:29.700088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"}
{"level":"warn","ts":"2026-05-09T16:54:29.706386Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-09T16:54:29.708259Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-09T16:54:29.710142Z","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-09T16:54:29.712323Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-09T16:54:29.712487Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-09T16:54:29.712654Z","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-09T16:54:29.712905Z","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-09T16:54:29.712941Z","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-09T16:54:29.71464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"}
{"level":"info","ts":"2026-05-09T16:54:29.714824Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]}
{"level":"info","ts":"2026-05-09T16:54:29.715132Z","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-09T16:54:29.715299Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"}
{"level":"info","ts":"2026-05-09T16:54:29.715388Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"}
{"level":"info","ts":"2026-05-09T16:54:29.715398Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-09T16:54:29.71543Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-09T16:54:30.401141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-09T16:54:30.401245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-09T16:54:30.401332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"}
{"level":"info","ts":"2026-05-09T16:54:30.401381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"}
{"level":"info","ts":"2026-05-09T16:54:30.4014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"}
{"level":"info","ts":"2026-05-09T16:54:30.401424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"}
{"level":"info","ts":"2026-05-09T16:54:30.40144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"}
{"level":"info","ts":"2026-05-09T16:54:30.402586Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:54:30.403621Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T16:54:30.403632Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-09T16:54:30.403908Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T16:54:30.404312Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-09T16:54:30.404457Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-09T16:54:30.404703Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:54:30.40754Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"}
{"level":"info","ts":"2026-05-09T16:54:30.407604Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-09T16:54:30.415949Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:54:30.415997Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:55:01.412642Z","caller":"traceutil/trace.go:171","msg":"trace[1794057936] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"221.09021ms","start":"2026-05-09T16:55:01.191482Z","end":"2026-05-09T16:55:01.412572Z","steps":["trace[1794057936] 'process raft request'  (duration: 219.834047ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:06.255901Z","caller":"traceutil/trace.go:171","msg":"trace[1291936820] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"142.284396ms","start":"2026-05-09T16:55:06.113587Z","end":"2026-05-09T16:55:06.255871Z","steps":["trace[1291936820] 'process raft request'  (duration: 141.636718ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:06.373019Z","caller":"traceutil/trace.go:171","msg":"trace[359389368] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"204.738078ms","start":"2026-05-09T16:55:06.168246Z","end":"2026-05-09T16:55:06.372984Z","steps":["trace[359389368] 'process raft request'  (duration: 189.248008ms)","trace[359389368] 'compare'  (duration: 15.181792ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:06.845684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.273843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8w8q8\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-09T16:55:06.845837Z","caller":"traceutil/trace.go:171","msg":"trace[1223059984] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8w8q8; range_end:; response_count:1; response_revision:616; }","duration":"328.46968ms","start":"2026-05-09T16:55:06.517345Z","end":"2026-05-09T16:55:06.845814Z","steps":["trace[1223059984] 'range keys from in-memory index tree'  (duration: 328.087768ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:06.84589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:06.517325Z","time spent":"328.549081ms","remote":"127.0.0.1:50594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-8w8q8\" "}
{"level":"warn","ts":"2026-05-09T16:55:06.845688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.874689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:06.846009Z","caller":"traceutil/trace.go:171","msg":"trace[1200696128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"188.24121ms","start":"2026-05-09T16:55:06.657744Z","end":"2026-05-09T16:55:06.845985Z","steps":["trace[1200696128] 'range keys from in-memory index tree'  (duration: 187.802738ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:29.757048Z","caller":"traceutil/trace.go:171","msg":"trace[405826412] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"115.553384ms","start":"2026-05-09T16:55:29.641469Z","end":"2026-05-09T16:55:29.757022Z","steps":["trace[405826412] 'read index received'  (duration: 115.313837ms)","trace[405826412] 'applied index is now lower than readState.Index'  (duration: 238.227µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:29.757121Z","caller":"traceutil/trace.go:171","msg":"trace[501694408] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"157.553097ms","start":"2026-05-09T16:55:29.59954Z","end":"2026-05-09T16:55:29.757093Z","steps":["trace[501694408] 'process raft request'  (duration: 157.31219ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:29.75733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.364765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:29.757375Z","caller":"traceutil/trace.go:171","msg":"trace[1853148455] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"102.481398ms","start":"2026-05-09T16:55:29.654882Z","end":"2026-05-09T16:55:29.757363Z","steps":["trace[1853148455] 'agreement among raft nodes before linearized reading'  (duration: 102.330134ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:29.757381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.901264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lqws5\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-05-09T16:55:29.75748Z","caller":"traceutil/trace.go:171","msg":"trace[1326342490] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lqws5; range_end:; response_count:1; response_revision:800; }","duration":"116.039017ms","start":"2026-05-09T16:55:29.641412Z","end":"2026-05-09T16:55:29.757451Z","steps":["trace[1326342490] 'agreement among raft nodes before linearized reading'  (duration: 115.78283ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:45.819677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.054216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:56:45.819803Z","caller":"traceutil/trace.go:171","msg":"trace[1929986704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1864; }","duration":"162.21749ms","start":"2026-05-09T16:56:45.657552Z","end":"2026-05-09T16:56:45.81977Z","steps":["trace[1929986704] 'range keys from in-memory index tree'  (duration: 161.959492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:45.819767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.970415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-09T16:56:45.819901Z","caller":"traceutil/trace.go:171","msg":"trace[550383699] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1864; }","duration":"114.189231ms","start":"2026-05-09T16:56:45.705674Z","end":"2026-05-09T16:56:45.819863Z","steps":["trace[550383699] 'range keys from in-memory index tree'  (duration: 113.740119ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:45.819866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.373888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ca870fa1-7c5f-49b2-a7fc-d03523098a23\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-09T16:56:45.820001Z","caller":"traceutil/trace.go:171","msg":"trace[483663879] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ca870fa1-7c5f-49b2-a7fc-d03523098a23; range_end:; response_count:1; response_revision:1864; }","duration":"284.603284ms","start":"2026-05-09T16:56:45.535369Z","end":"2026-05-09T16:56:45.819973Z","steps":["trace[483663879] 'range keys from in-memory index tree'  (duration: 284.113291ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:35.235639Z","caller":"traceutil/trace.go:171","msg":"trace[1698824477] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"117.453063ms","start":"2026-05-09T16:57:35.11815Z","end":"2026-05-09T16:57:35.235603Z","steps":["trace[1698824477] 'process raft request'  (duration: 117.248507ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:35.322492Z","caller":"traceutil/trace.go:171","msg":"trace[1433324670] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"200.070525ms","start":"2026-05-09T16:57:35.122374Z","end":"2026-05-09T16:57:35.322445Z","steps":["trace[1433324670] 'process raft request'  (duration: 178.437906ms)","trace[1433324670] 'compare'  (duration: 21.335781ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:57:35.322799Z","caller":"traceutil/trace.go:171","msg":"trace[1237952887] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"188.093068ms","start":"2026-05-09T16:57:35.134674Z","end":"2026-05-09T16:57:35.322767Z","steps":["trace[1237952887] 'process raft request'  (duration: 187.698397ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:35.322899Z","caller":"traceutil/trace.go:171","msg":"trace[1033698318] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2262; }","duration":"106.667928ms","start":"2026-05-09T16:57:35.216207Z","end":"2026-05-09T16:57:35.322874Z","steps":["trace[1033698318] 'read index received'  (duration: 19.310537ms)","trace[1033698318] 'applied index is now lower than readState.Index'  (duration: 87.355951ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:57:35.323211Z","caller":"traceutil/trace.go:171","msg":"trace[1114916870] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"175.234248ms","start":"2026-05-09T16:57:35.147939Z","end":"2026-05-09T16:57:35.323173Z","steps":["trace[1114916870] 'process raft request'  (duration: 174.729094ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:57:35.323293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.071249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-09T16:57:35.323343Z","caller":"traceutil/trace.go:171","msg":"trace[1919323029] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"107.188262ms","start":"2026-05-09T16:57:35.21614Z","end":"2026-05-09T16:57:35.323328Z","steps":["trace[1919323029] 'agreement among raft nodes before linearized reading'  (duration: 106.833333ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:35.535978Z","caller":"traceutil/trace.go:171","msg":"trace[80152481] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"115.578671ms","start":"2026-05-09T16:57:35.420362Z","end":"2026-05-09T16:57:35.535941Z","steps":["trace[80152481] 'process raft request'  (duration: 29.694979ms)","trace[80152481] 'compare'  (duration: 85.668056ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:58:50.401114Z","caller":"traceutil/trace.go:171","msg":"trace[2069309792] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"230.623863ms","start":"2026-05-09T16:58:50.170457Z","end":"2026-05-09T16:58:50.401081Z","steps":["trace[2069309792] 'process raft request'  (duration: 230.417347ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:01:20.239087Z","caller":"traceutil/trace.go:171","msg":"trace[510120271] transaction","detail":"{read_only:false; response_revision:3774; number_of_response:1; }","duration":"192.801683ms","start":"2026-05-09T17:01:20.046221Z","end":"2026-05-09T17:01:20.239023Z","steps":["trace[510120271] 'process raft request'  (duration: 110.181681ms)","trace[510120271] 'compare'  (duration: 82.441227ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:01:20.240291Z","caller":"traceutil/trace.go:171","msg":"trace[268929619] transaction","detail":"{read_only:false; response_revision:3775; number_of_response:1; }","duration":"106.202122ms","start":"2026-05-09T17:01:20.134068Z","end":"2026-05-09T17:01:20.24027Z","steps":["trace[268929619] 'process raft request'  (duration: 106.057038ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:02:40.351862Z","caller":"traceutil/trace.go:171","msg":"trace[1868759274] linearizableReadLoop","detail":"{readStateIndex:4997; appliedIndex:4996; }","duration":"181.764604ms","start":"2026-05-09T17:02:40.170078Z","end":"2026-05-09T17:02:40.351843Z","steps":["trace[1868759274] 'read index received'  (duration: 181.547818ms)","trace[1868759274] 'applied index is now lower than readState.Index'  (duration: 215.616µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:02:40.351988Z","caller":"traceutil/trace.go:171","msg":"trace[507684769] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"197.19238ms","start":"2026-05-09T17:02:40.154787Z","end":"2026-05-09T17:02:40.351979Z","steps":["trace[507684769] 'process raft request'  (duration: 196.868012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:02:40.352698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.530874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-09T17:02:40.352836Z","caller":"traceutil/trace.go:171","msg":"trace[177505425] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4816; }","duration":"182.77932ms","start":"2026-05-09T17:02:40.170016Z","end":"2026-05-09T17:02:40.352795Z","steps":["trace[177505425] 'agreement among raft nodes before linearized reading'  (duration: 182.319268ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:02:44.256779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.135849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T17:02:44.256863Z","caller":"traceutil/trace.go:171","msg":"trace[1731552820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4973; }","duration":"101.241392ms","start":"2026-05-09T17:02:44.155605Z","end":"2026-05-09T17:02:44.256846Z","steps":["trace[1731552820] 'range keys from in-memory index tree'  (duration: 100.954564ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:04:30.432195Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3003}
{"level":"info","ts":"2026-05-09T17:04:30.516213Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3003,"took":"81.880631ms","hash":4138366731,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":31907840,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T17:04:30.516294Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4138366731,"revision":3003,"compact-revision":-1}
{"level":"warn","ts":"2026-05-09T17:08:50.536411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.699139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-09T17:08:50.53651Z","caller":"traceutil/trace.go:171","msg":"trace[544009250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8090; }","duration":"217.847373ms","start":"2026-05-09T17:08:50.318641Z","end":"2026-05-09T17:08:50.536488Z","steps":["trace[544009250] 'range keys from in-memory index tree'  (duration: 217.469692ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:08:50.536513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.357948ms","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-09T17:08:50.536758Z","caller":"traceutil/trace.go:171","msg":"trace[1738172042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8090; }","duration":"199.643936ms","start":"2026-05-09T17:08:50.337065Z","end":"2026-05-09T17:08:50.536709Z","steps":["trace[1738172042] 'range keys from in-memory index tree'  (duration: 199.09203ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:08:50.536591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.28014ms","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":"warn","ts":"2026-05-09T17:08:50.536809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.420486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-09T17:08:50.536914Z","caller":"traceutil/trace.go:171","msg":"trace[464216193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8090; }","duration":"200.586331ms","start":"2026-05-09T17:08:50.336306Z","end":"2026-05-09T17:08:50.536893Z","steps":["trace[464216193] 'range keys from in-memory index tree'  (duration: 200.204671ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:08:50.53689Z","caller":"traceutil/trace.go:171","msg":"trace[791656625] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8090; }","duration":"201.593169ms","start":"2026-05-09T17:08:50.335245Z","end":"2026-05-09T17:08:50.536838Z","steps":["trace[791656625] 'range keys from in-memory index tree'  (duration: 201.103326ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:02.14932Z","caller":"traceutil/trace.go:171","msg":"trace[1054660176] transaction","detail":"{read_only:false; response_revision:8147; number_of_response:1; }","duration":"201.106066ms","start":"2026-05-09T17:09:01.948181Z","end":"2026-05-09T17:09:02.149287Z","steps":["trace[1054660176] 'process raft request'  (duration: 200.817998ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:02.150317Z","caller":"traceutil/trace.go:171","msg":"trace[1648488726] linearizableReadLoop","detail":"{readStateIndex:8430; appliedIndex:8427; }","duration":"153.118064ms","start":"2026-05-09T17:09:01.997176Z","end":"2026-05-09T17:09:02.150294Z","steps":["trace[1648488726] 'read index received'  (duration: 151.626403ms)","trace[1648488726] 'applied index is now lower than readState.Index'  (duration: 1.490641ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:02.150371Z","caller":"traceutil/trace.go:171","msg":"trace[1800024827] transaction","detail":"{read_only:false; response_revision:8148; number_of_response:1; }","duration":"200.187609ms","start":"2026-05-09T17:09:01.950153Z","end":"2026-05-09T17:09:02.150341Z","steps":["trace[1800024827] 'process raft request'  (duration: 199.855981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:02.150395Z","caller":"traceutil/trace.go:171","msg":"trace[1774154080] transaction","detail":"{read_only:false; response_revision:8149; number_of_response:1; }","duration":"195.38765ms","start":"2026-05-09T17:09:01.954967Z","end":"2026-05-09T17:09:02.150355Z","steps":["trace[1774154080] 'process raft request'  (duration: 195.271907ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:02.150512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.312539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-svm9g\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-09T17:09:02.150551Z","caller":"traceutil/trace.go:171","msg":"trace[385426910] range","detail":"{range_begin:/registry/pods/openstack/keepalived-svm9g; range_end:; response_count:1; response_revision:8149; }","duration":"153.386182ms","start":"2026-05-09T17:09:01.997155Z","end":"2026-05-09T17:09:02.150541Z","steps":["trace[385426910] 'agreement among raft nodes before linearized reading'  (duration: 153.233558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:02.970208Z","caller":"traceutil/trace.go:171","msg":"trace[735539256] linearizableReadLoop","detail":"{readStateIndex:8435; appliedIndex:8434; }","duration":"331.360886ms","start":"2026-05-09T17:09:02.638818Z","end":"2026-05-09T17:09:02.970179Z","steps":["trace[735539256] 'read index received'  (duration: 262.483664ms)","trace[735539256] 'applied index is now lower than readState.Index'  (duration: 68.876292ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:02.970337Z","caller":"traceutil/trace.go:171","msg":"trace[423823649] transaction","detail":"{read_only:false; response_revision:8154; number_of_response:1; }","duration":"347.143857ms","start":"2026-05-09T17:09:02.62317Z","end":"2026-05-09T17:09:02.970314Z","steps":["trace[423823649] 'process raft request'  (duration: 278.1265ms)","trace[423823649] 'compare'  (duration: 68.670757ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:02.970364Z","caller":"traceutil/trace.go:171","msg":"trace[1163446355] transaction","detail":"{read_only:false; response_revision:8155; number_of_response:1; }","duration":"327.472609ms","start":"2026-05-09T17:09:02.642865Z","end":"2026-05-09T17:09:02.970338Z","steps":["trace[1163446355] 'process raft request'  (duration: 327.281774ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:02.970608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.1509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-09T17:09:02.970637Z","caller":"traceutil/trace.go:171","msg":"trace[746517300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8155; }","duration":"342.212211ms","start":"2026-05-09T17:09:02.628417Z","end":"2026-05-09T17:09:02.97063Z","steps":["trace[746517300] 'agreement among raft nodes before linearized reading'  (duration: 341.867522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:02.970658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:09:02.628406Z","time spent":"342.246092ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-09T17:09:02.970892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:09:02.623151Z","time spent":"347.211358ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8143 > 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-09T17:09:02.970993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:09:02.642848Z","time spent":"327.583902ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8144 > 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-09T17:09:30.150806Z","caller":"traceutil/trace.go:171","msg":"trace[1123585427] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"198.951025ms","start":"2026-05-09T17:09:29.951828Z","end":"2026-05-09T17:09:30.150779Z","steps":["trace[1123585427] 'process raft request'  (duration: 198.800171ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:30.440283Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6137}
{"level":"info","ts":"2026-05-09T17:09:30.537513Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6137,"took":"94.611353ms","hash":3913562289,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":23183360,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-09T17:09:30.537601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3913562289,"revision":6137,"compact-revision":3003}
{"level":"info","ts":"2026-05-09T17:09:41.850469Z","caller":"traceutil/trace.go:171","msg":"trace[341829547] linearizableReadLoop","detail":"{readStateIndex:8752; appliedIndex:8751; }","duration":"125.624024ms","start":"2026-05-09T17:09:41.724822Z","end":"2026-05-09T17:09:41.850446Z","steps":["trace[341829547] 'read index received'  (duration: 125.419179ms)","trace[341829547] 'applied index is now lower than readState.Index'  (duration: 203.955µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:41.850525Z","caller":"traceutil/trace.go:171","msg":"trace[1950973390] transaction","detail":"{read_only:false; response_revision:8456; number_of_response:1; }","duration":"126.726634ms","start":"2026-05-09T17:09:41.72376Z","end":"2026-05-09T17:09:41.850487Z","steps":["trace[1950973390] 'process raft request'  (duration: 126.538229ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:41.85073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.885701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-lrvwh\" ","response":"range_response_count:1 size:2802"}
{"level":"info","ts":"2026-05-09T17:09:41.850813Z","caller":"traceutil/trace.go:171","msg":"trace[1597389025] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-lrvwh; range_end:; response_count:1; response_revision:8456; }","duration":"125.991124ms","start":"2026-05-09T17:09:41.7248Z","end":"2026-05-09T17:09:41.850791Z","steps":["trace[1597389025] 'agreement among raft nodes before linearized reading'  (duration: 125.763158ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:41.987408Z","caller":"traceutil/trace.go:171","msg":"trace[77310107] linearizableReadLoop","detail":"{readStateIndex:8753; appliedIndex:8752; }","duration":"132.030981ms","start":"2026-05-09T17:09:41.85535Z","end":"2026-05-09T17:09:41.987381Z","steps":["trace[77310107] 'read index received'  (duration: 114.766997ms)","trace[77310107] 'applied index is now lower than readState.Index'  (duration: 17.262924ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:41.987685Z","caller":"traceutil/trace.go:171","msg":"trace[1667816565] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8457; }","duration":"133.955522ms","start":"2026-05-09T17:09:41.853705Z","end":"2026-05-09T17:09:41.98766Z","steps":["trace[1667816565] 'process raft request'  (duration: 116.524934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:41.989743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.377134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lrvwh\" ","response":"range_response_count:1 size:4650"}
{"level":"info","ts":"2026-05-09T17:09:41.989802Z","caller":"traceutil/trace.go:171","msg":"trace[1137978142] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lrvwh; range_end:; response_count:1; response_revision:8457; }","duration":"134.470017ms","start":"2026-05-09T17:09:41.855314Z","end":"2026-05-09T17:09:41.989784Z","steps":["trace[1137978142] 'agreement among raft nodes before linearized reading'  (duration: 132.179255ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:42.492476Z","caller":"traceutil/trace.go:171","msg":"trace[1895091749] linearizableReadLoop","detail":"{readStateIndex:8757; appliedIndex:8754; }","duration":"110.901411ms","start":"2026-05-09T17:09:42.381556Z","end":"2026-05-09T17:09:42.492457Z","steps":["trace[1895091749] 'read index received'  (duration: 52.985532ms)","trace[1895091749] 'applied index is now lower than readState.Index'  (duration: 57.915099ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:42.492564Z","caller":"traceutil/trace.go:171","msg":"trace[926443386] transaction","detail":"{read_only:false; response_revision:8460; number_of_response:1; }","duration":"147.546816ms","start":"2026-05-09T17:09:42.344997Z","end":"2026-05-09T17:09:42.492544Z","steps":["trace[926443386] 'process raft request'  (duration: 147.31558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:42.492579Z","caller":"traceutil/trace.go:171","msg":"trace[430292137] transaction","detail":"{read_only:false; response_revision:8461; number_of_response:1; }","duration":"147.224537ms","start":"2026-05-09T17:09:42.345344Z","end":"2026-05-09T17:09:42.492569Z","steps":["trace[430292137] 'process raft request'  (duration: 147.073392ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:42.49269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.117287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-svm9g\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-09T17:09:42.492775Z","caller":"traceutil/trace.go:171","msg":"trace[1302628229] range","detail":"{range_begin:/registry/pods/openstack/keepalived-svm9g; range_end:; response_count:1; response_revision:8461; }","duration":"111.23819ms","start":"2026-05-09T17:09:42.381521Z","end":"2026-05-09T17:09:42.49276Z","steps":["trace[1302628229] 'agreement among raft nodes before linearized reading'  (duration: 111.043714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:42.607945Z","caller":"traceutil/trace.go:171","msg":"trace[399014834] linearizableReadLoop","detail":"{readStateIndex:8759; appliedIndex:8757; }","duration":"115.387843ms","start":"2026-05-09T17:09:42.49254Z","end":"2026-05-09T17:09:42.607928Z","steps":["trace[399014834] 'read index received'  (duration: 115.131636ms)","trace[399014834] 'applied index is now lower than readState.Index'  (duration: 254.977µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:42.608008Z","caller":"traceutil/trace.go:171","msg":"trace[744373571] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"122.092937ms","start":"2026-05-09T17:09:42.485898Z","end":"2026-05-09T17:09:42.607991Z","steps":["trace[744373571] 'process raft request'  (duration: 121.964414ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:09:42.608126Z","caller":"traceutil/trace.go:171","msg":"trace[2036371579] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"128.901853ms","start":"2026-05-09T17:09:42.479196Z","end":"2026-05-09T17:09:42.608098Z","steps":["trace[2036371579] 'process raft request'  (duration: 128.570044ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:42.608255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.813908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lrvwh\" ","response":"range_response_count:1 size:4650"}
{"level":"info","ts":"2026-05-09T17:09:42.608294Z","caller":"traceutil/trace.go:171","msg":"trace[589037850] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lrvwh; range_end:; response_count:1; response_revision:8463; }","duration":"129.87466ms","start":"2026-05-09T17:09:42.478409Z","end":"2026-05-09T17:09:42.608284Z","steps":["trace[589037850] 'agreement among raft nodes before linearized reading'  (duration: 129.786338ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:42.608163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.443396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-09T17:09:42.608382Z","caller":"traceutil/trace.go:171","msg":"trace[1418205168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8463; }","duration":"126.683253ms","start":"2026-05-09T17:09:42.481686Z","end":"2026-05-09T17:09:42.608369Z","steps":["trace[1418205168] 'agreement among raft nodes before linearized reading'  (duration: 126.353864ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:42.608475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.286181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228491"}
{"level":"info","ts":"2026-05-09T17:09:42.608556Z","caller":"traceutil/trace.go:171","msg":"trace[262351522] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8463; }","duration":"111.423854ms","start":"2026-05-09T17:09:42.497112Z","end":"2026-05-09T17:09:42.608536Z","steps":["trace[262351522] 'agreement among raft nodes before linearized reading'  (duration: 110.954711ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:10:30.545054Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002416.wal"}
{"level":"info","ts":"2026-05-09T17:11:57.561363Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T17:11:57.568803Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-09T17:11:57.568898Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-09T17:14:22.094962Z","caller":"traceutil/trace.go:171","msg":"trace[552653174] transaction","detail":"{read_only:false; response_revision:10988; number_of_response:1; }","duration":"153.650205ms","start":"2026-05-09T17:14:21.941291Z","end":"2026-05-09T17:14:22.094941Z","steps":["trace[552653174] 'process raft request'  (duration: 153.531492ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:14:30.446433Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8356}
{"level":"info","ts":"2026-05-09T17:14:30.522321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8356,"took":"73.538774ms","hash":4034238641,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":27267072,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-09T17:14:30.522403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4034238641,"revision":8356,"compact-revision":6137}
{"level":"info","ts":"2026-05-09T17:19:30.452922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11058}
{"level":"info","ts":"2026-05-09T17:19:30.532815Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11058,"took":"78.036365ms","hash":1128132638,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":28143616,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-09T17:19:30.532869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1128132638,"revision":11058,"compact-revision":8356}
{"level":"info","ts":"2026-05-09T17:20:28.982851Z","caller":"traceutil/trace.go:171","msg":"trace[1457520841] transaction","detail":"{read_only:false; response_revision:13475; number_of_response:1; }","duration":"146.145109ms","start":"2026-05-09T17:20:28.83668Z","end":"2026-05-09T17:20:28.982825Z","steps":["trace[1457520841] 'process raft request'  (duration: 146.039136ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:20:42.714758Z","caller":"traceutil/trace.go:171","msg":"trace[1051033119] transaction","detail":"{read_only:false; response_revision:13558; number_of_response:1; }","duration":"118.447215ms","start":"2026-05-09T17:20:42.596278Z","end":"2026-05-09T17:20:42.714726Z","steps":["trace[1051033119] 'process raft request'  (duration: 118.223639ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:20:42.734285Z","caller":"traceutil/trace.go:171","msg":"trace[1215974456] transaction","detail":"{read_only:false; response_revision:13559; number_of_response:1; }","duration":"135.597443ms","start":"2026-05-09T17:20:42.59865Z","end":"2026-05-09T17:20:42.734248Z","steps":["trace[1215974456] 'process raft request'  (duration: 135.292374ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:20:43.653152Z","caller":"traceutil/trace.go:171","msg":"trace[2099741795] linearizableReadLoop","detail":"{readStateIndex:14024; appliedIndex:14023; }","duration":"223.347022ms","start":"2026-05-09T17:20:43.42978Z","end":"2026-05-09T17:20:43.653127Z","steps":["trace[2099741795] 'read index received'  (duration: 223.199638ms)","trace[2099741795] 'applied index is now lower than readState.Index'  (duration: 146.304µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:20:43.65331Z","caller":"traceutil/trace.go:171","msg":"trace[315552541] transaction","detail":"{read_only:false; response_revision:13565; number_of_response:1; }","duration":"225.364136ms","start":"2026-05-09T17:20:43.427934Z","end":"2026-05-09T17:20:43.653298Z","steps":["trace[315552541] 'process raft request'  (duration: 225.050098ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:20:43.653654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.858326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:138"}
{"level":"info","ts":"2026-05-09T17:20:43.653744Z","caller":"traceutil/trace.go:171","msg":"trace[2050142676] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:13565; }","duration":"212.952669ms","start":"2026-05-09T17:20:43.440769Z","end":"2026-05-09T17:20:43.653722Z","steps":["trace[2050142676] 'agreement among raft nodes before linearized reading'  (duration: 212.671781ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:20:43.653795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.977228ms","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-09T17:20:43.65389Z","caller":"traceutil/trace.go:171","msg":"trace[96495675] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:13565; }","duration":"224.106872ms","start":"2026-05-09T17:20:43.429764Z","end":"2026-05-09T17:20:43.653871Z","steps":["trace[96495675] 'agreement among raft nodes before linearized reading'  (duration: 223.809004ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:21:03.87184Z","caller":"traceutil/trace.go:171","msg":"trace[336164017] transaction","detail":"{read_only:false; response_revision:13865; number_of_response:1; }","duration":"120.437059ms","start":"2026-05-09T17:21:03.751341Z","end":"2026-05-09T17:21:03.871778Z","steps":["trace[336164017] 'process raft request'  (duration: 119.982127ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:24:30.458861Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13090}
{"level":"info","ts":"2026-05-09T17:24:30.53853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13090,"took":"76.647756ms","hash":1745022382,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":31678464,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T17:24:30.538601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1745022382,"revision":13090,"compact-revision":11058}
{"level":"info","ts":"2026-05-09T17:27:43.619054Z","caller":"traceutil/trace.go:171","msg":"trace[1401503891] linearizableReadLoop","detail":"{readStateIndex:17658; appliedIndex:17658; }","duration":"100.32209ms","start":"2026-05-09T17:27:43.518696Z","end":"2026-05-09T17:27:43.619018Z","steps":["trace[1401503891] 'read index received'  (duration: 100.31572ms)","trace[1401503891] 'applied index is now lower than readState.Index'  (duration: 4.85µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:27:43.619278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.550437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-w9mcp\" ","response":"range_response_count:1 size:22133"}
{"level":"info","ts":"2026-05-09T17:27:43.619337Z","caller":"traceutil/trace.go:171","msg":"trace[1405430242] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-w9mcp; range_end:; response_count:1; response_revision:17083; }","duration":"100.64693ms","start":"2026-05-09T17:27:43.518661Z","end":"2026-05-09T17:27:43.619308Z","steps":["trace[1405430242] 'agreement among raft nodes before linearized reading'  (duration: 100.482976ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:27:43.894936Z","caller":"traceutil/trace.go:171","msg":"trace[1999526081] linearizableReadLoop","detail":"{readStateIndex:17659; appliedIndex:17658; }","duration":"262.052215ms","start":"2026-05-09T17:27:43.63286Z","end":"2026-05-09T17:27:43.894913Z","steps":["trace[1999526081] 'read index received'  (duration: 235.037069ms)","trace[1999526081] 'applied index is now lower than readState.Index'  (duration: 27.013916ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:27:43.895074Z","caller":"traceutil/trace.go:171","msg":"trace[1130447710] transaction","detail":"{read_only:false; response_revision:17084; number_of_response:1; }","duration":"274.730629ms","start":"2026-05-09T17:27:43.620309Z","end":"2026-05-09T17:27:43.895039Z","steps":["trace[1130447710] 'process raft request'  (duration: 247.58742ms)","trace[1130447710] 'compare'  (duration: 26.926653ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:27:43.895904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.99578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:945916"}
{"level":"info","ts":"2026-05-09T17:27:43.895951Z","caller":"traceutil/trace.go:171","msg":"trace[747364543] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:17084; }","duration":"263.120393ms","start":"2026-05-09T17:27:43.632819Z","end":"2026-05-09T17:27:43.895939Z","steps":["trace[747364543] 'agreement among raft nodes before linearized reading'  (duration: 262.210819ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:27:44.109314Z","caller":"traceutil/trace.go:171","msg":"trace[884467794] linearizableReadLoop","detail":"{readStateIndex:17660; appliedIndex:17659; }","duration":"214.246962ms","start":"2026-05-09T17:27:43.895004Z","end":"2026-05-09T17:27:44.109251Z","steps":["trace[884467794] 'read index received'  (duration: 199.004938ms)","trace[884467794] 'applied index is now lower than readState.Index'  (duration: 15.240904ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:27:44.109657Z","caller":"traceutil/trace.go:171","msg":"trace[1457193385] transaction","detail":"{read_only:false; response_revision:17085; number_of_response:1; }","duration":"473.719948ms","start":"2026-05-09T17:27:43.635917Z","end":"2026-05-09T17:27:44.109637Z","steps":["trace[1457193385] 'process raft request'  (duration: 458.052621ms)","trace[1457193385] 'compare'  (duration: 14.992738ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:27:44.109814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:27:43.635894Z","time spent":"473.808259ms","remote":"127.0.0.1:50594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20988,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-bmdlj\" mod_revision:17002 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-bmdlj\" value_size:20924 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-bmdlj\" > >"}
{"level":"warn","ts":"2026-05-09T17:27:44.109821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.743995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"}
{"level":"info","ts":"2026-05-09T17:27:44.109913Z","caller":"traceutil/trace.go:171","msg":"trace[922726498] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:17085; }","duration":"211.9071ms","start":"2026-05-09T17:27:43.897985Z","end":"2026-05-09T17:27:44.109892Z","steps":["trace[922726498] 'agreement among raft nodes before linearized reading'  (duration: 211.715524ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:27:44.109927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.109653ms","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-09T17:27:44.109989Z","caller":"traceutil/trace.go:171","msg":"trace[299066411] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17085; }","duration":"166.224546ms","start":"2026-05-09T17:27:43.943746Z","end":"2026-05-09T17:27:44.10997Z","steps":["trace[299066411] 'agreement among raft nodes before linearized reading'  (duration: 165.99915ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:27:44.110179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.34679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/clustering\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:27:44.110201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.159917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:27:44.110217Z","caller":"traceutil/trace.go:171","msg":"trace[39554990] range","detail":"{range_begin:/registry/ingress/openstack/clustering; range_end:; response_count:0; response_revision:17085; }","duration":"198.400241ms","start":"2026-05-09T17:27:43.911808Z","end":"2026-05-09T17:27:44.110208Z","steps":["trace[39554990] 'agreement among raft nodes before linearized reading'  (duration: 198.340219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:27:44.110236Z","caller":"traceutil/trace.go:171","msg":"trace[1438263187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17085; }","duration":"453.221328ms","start":"2026-05-09T17:27:43.657001Z","end":"2026-05-09T17:27:44.110223Z","steps":["trace[1438263187] 'agreement among raft nodes before linearized reading'  (duration: 453.172207ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:27:44.110267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:27:43.656985Z","time spent":"453.27483ms","remote":"127.0.0.1:50420","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-09T17:27:44.110437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.038855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-09T17:27:44.110475Z","caller":"traceutil/trace.go:171","msg":"trace[2049809035] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17085; }","duration":"204.092567ms","start":"2026-05-09T17:27:43.906372Z","end":"2026-05-09T17:27:44.110465Z","steps":["trace[2049809035] 'agreement among raft nodes before linearized reading'  (duration: 203.972214ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:29:30.464402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15614}
{"level":"info","ts":"2026-05-09T17:29:30.559724Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15614,"took":"91.669165ms","hash":2696070125,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":34406400,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-09T17:29:30.559827Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2696070125,"revision":15614,"compact-revision":13090}
{"level":"info","ts":"2026-05-09T17:32:11.599604Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T17:32:11.604761Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-09T17:32:11.604945Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-09T17:32:37.431907Z","caller":"traceutil/trace.go:171","msg":"trace[1170327517] transaction","detail":"{read_only:false; response_revision:19488; number_of_response:1; }","duration":"115.155103ms","start":"2026-05-09T17:32:37.316726Z","end":"2026-05-09T17:32:37.431881Z","steps":["trace[1170327517] 'process raft request'  (duration: 114.948268ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:32:37.446734Z","caller":"traceutil/trace.go:171","msg":"trace[186376026] transaction","detail":"{read_only:false; response_revision:19489; number_of_response:1; }","duration":"125.489865ms","start":"2026-05-09T17:32:37.321211Z","end":"2026-05-09T17:32:37.4467Z","steps":["trace[186376026] 'process raft request'  (duration: 125.327331ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:32:58.449126Z","caller":"traceutil/trace.go:171","msg":"trace[367668458] transaction","detail":"{read_only:false; response_revision:19597; number_of_response:1; }","duration":"108.193024ms","start":"2026-05-09T17:32:58.340903Z","end":"2026-05-09T17:32:58.449096Z","steps":["trace[367668458] 'process raft request'  (duration: 108.025559ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:32:58.605776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.03265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:32:58.605862Z","caller":"traceutil/trace.go:171","msg":"trace[1305090610] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19597; }","duration":"133.162004ms","start":"2026-05-09T17:32:58.472681Z","end":"2026-05-09T17:32:58.605843Z","steps":["trace[1305090610] 'range keys from in-memory index tree'  (duration: 132.800913ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:32:58.864833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.360708ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188045242 > lease_revoke:<id:3e739e0da9751af0>","response":"size:29"}
{"level":"info","ts":"2026-05-09T17:32:58.865068Z","caller":"traceutil/trace.go:171","msg":"trace[2123187539] linearizableReadLoop","detail":"{readStateIndex:20254; appliedIndex:20253; }","duration":"256.027638ms","start":"2026-05-09T17:32:58.609014Z","end":"2026-05-09T17:32:58.865041Z","steps":["trace[2123187539] 'read index received'  (duration: 42.391µs)","trace[2123187539] 'applied index is now lower than readState.Index'  (duration: 255.982377ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:32:58.865349Z","caller":"traceutil/trace.go:171","msg":"trace[789530587] transaction","detail":"{read_only:false; response_revision:19598; number_of_response:1; }","duration":"134.313966ms","start":"2026-05-09T17:32:58.731001Z","end":"2026-05-09T17:32:58.865315Z","steps":["trace[789530587] 'process raft request'  (duration: 133.943526ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:32:58.865389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.474756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:32:58.865489Z","caller":"traceutil/trace.go:171","msg":"trace[1430061419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19598; }","duration":"207.60077ms","start":"2026-05-09T17:32:58.657868Z","end":"2026-05-09T17:32:58.865468Z","steps":["trace[1430061419] 'agreement among raft nodes before linearized reading'  (duration: 207.348993ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:32:58.865698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.656796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:32:58.866059Z","caller":"traceutil/trace.go:171","msg":"trace[1810070969] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19598; }","duration":"256.811389ms","start":"2026-05-09T17:32:58.608977Z","end":"2026-05-09T17:32:58.865788Z","steps":["trace[1810070969] 'agreement among raft nodes before linearized reading'  (duration: 256.236914ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:32:59.752052Z","caller":"traceutil/trace.go:171","msg":"trace[210198674] transaction","detail":"{read_only:false; response_revision:19600; number_of_response:1; }","duration":"235.53669ms","start":"2026-05-09T17:32:59.516476Z","end":"2026-05-09T17:32:59.752013Z","steps":["trace[210198674] 'process raft request'  (duration: 146.387753ms)","trace[210198674] 'compare'  (duration: 89.004093ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:34:30.471308Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18148}
{"level":"info","ts":"2026-05-09T17:34:30.580151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18148,"took":"104.993217ms","hash":549014539,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":30097408,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T17:34:30.580228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":549014539,"revision":18148,"compact-revision":15614}
{"level":"info","ts":"2026-05-09T17:36:33.985681Z","caller":"traceutil/trace.go:171","msg":"trace[1557677783] transaction","detail":"{read_only:false; response_revision:21918; number_of_response:1; }","duration":"189.593869ms","start":"2026-05-09T17:36:33.796056Z","end":"2026-05-09T17:36:33.98565Z","steps":["trace[1557677783] 'process raft request'  (duration: 189.360433ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:36:34.255045Z","caller":"traceutil/trace.go:171","msg":"trace[1240247317] transaction","detail":"{read_only:false; response_revision:21919; number_of_response:1; }","duration":"215.981349ms","start":"2026-05-09T17:36:34.039023Z","end":"2026-05-09T17:36:34.255004Z","steps":["trace[1240247317] 'process raft request'  (duration: 169.270707ms)","trace[1240247317] 'compare'  (duration: 46.411483ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:36:34.256151Z","caller":"traceutil/trace.go:171","msg":"trace[1706618625] transaction","detail":"{read_only:false; response_revision:21921; number_of_response:1; }","duration":"120.290354ms","start":"2026-05-09T17:36:34.135843Z","end":"2026-05-09T17:36:34.256133Z","steps":["trace[1706618625] 'process raft request'  (duration: 120.231392ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:36:34.256327Z","caller":"traceutil/trace.go:171","msg":"trace[995140354] transaction","detail":"{read_only:false; response_revision:21920; number_of_response:1; }","duration":"201.887804ms","start":"2026-05-09T17:36:34.054372Z","end":"2026-05-09T17:36:34.25626Z","steps":["trace[995140354] 'process raft request'  (duration: 201.585266ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:37:49.007093Z","caller":"traceutil/trace.go:171","msg":"trace[198766845] transaction","detail":"{read_only:false; response_revision:22747; number_of_response:1; }","duration":"167.026856ms","start":"2026-05-09T17:37:48.840023Z","end":"2026-05-09T17:37:49.00705Z","steps":["trace[198766845] 'process raft request'  (duration: 131.388148ms)","trace[198766845] 'compare'  (duration: 35.34793ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:30.477702Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20390}
{"level":"info","ts":"2026-05-09T17:39:30.584347Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20390,"took":"102.374139ms","hash":3197673100,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":43634688,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-05-09T17:39:30.584403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3197673100,"revision":20390,"compact-revision":18148}
{"level":"info","ts":"2026-05-09T17:39:41.017067Z","caller":"traceutil/trace.go:171","msg":"trace[1369687791] transaction","detail":"{read_only:false; response_revision:23833; number_of_response:1; }","duration":"107.398166ms","start":"2026-05-09T17:39:40.909633Z","end":"2026-05-09T17:39:41.017031Z","steps":["trace[1369687791] 'process raft request'  (duration: 107.214131ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:41.305069Z","caller":"traceutil/trace.go:171","msg":"trace[1221408602] transaction","detail":"{read_only:false; response_revision:23834; number_of_response:1; }","duration":"349.287246ms","start":"2026-05-09T17:39:40.95576Z","end":"2026-05-09T17:39:41.305047Z","steps":["trace[1221408602] 'process raft request'  (duration: 336.51189ms)","trace[1221408602] 'compare'  (duration: 12.673453ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:41.305185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:40.955728Z","time spent":"349.397778ms","remote":"127.0.0.1:50698","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:23821 > 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-09T17:39:41.33487Z","caller":"traceutil/trace.go:171","msg":"trace[940056482] linearizableReadLoop","detail":"{readStateIndex:24604; appliedIndex:24602; }","duration":"185.042745ms","start":"2026-05-09T17:39:41.149796Z","end":"2026-05-09T17:39:41.334839Z","steps":["trace[940056482] 'read index received'  (duration: 142.48851ms)","trace[940056482] 'applied index is now lower than readState.Index'  (duration: 42.553195ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:41.3349Z","caller":"traceutil/trace.go:171","msg":"trace[635394214] transaction","detail":"{read_only:false; response_revision:23835; number_of_response:1; }","duration":"211.189886ms","start":"2026-05-09T17:39:41.123675Z","end":"2026-05-09T17:39:41.334865Z","steps":["trace[635394214] 'process raft request'  (duration: 210.987001ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:41.335038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.22484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T17:39:41.335078Z","caller":"traceutil/trace.go:171","msg":"trace[678678102] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:23836; }","duration":"185.321962ms","start":"2026-05-09T17:39:41.149744Z","end":"2026-05-09T17:39:41.335066Z","steps":["trace[678678102] 'agreement among raft nodes before linearized reading'  (duration: 185.200189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:45.813108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.030016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T17:39:45.813211Z","caller":"traceutil/trace.go:171","msg":"trace[1618258298] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:23868; }","duration":"121.19737ms","start":"2026-05-09T17:39:45.691992Z","end":"2026-05-09T17:39:45.81319Z","steps":["trace[1618258298] 'count revisions from in-memory index tree'  (duration: 120.942464ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:45.813383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.182164ms","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-09T17:39:45.813459Z","caller":"traceutil/trace.go:171","msg":"trace[2040830099] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:23868; }","duration":"169.305887ms","start":"2026-05-09T17:39:45.644136Z","end":"2026-05-09T17:39:45.813442Z","steps":["trace[2040830099] 'count revisions from in-memory index tree'  (duration: 169.096692ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:45.813492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.429831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:45.813572Z","caller":"traceutil/trace.go:171","msg":"trace[665125996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23868; }","duration":"158.557216ms","start":"2026-05-09T17:39:45.654996Z","end":"2026-05-09T17:39:45.813553Z","steps":["trace[665125996] 'range keys from in-memory index tree'  (duration: 158.300758ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:45.968836Z","caller":"traceutil/trace.go:171","msg":"trace[1967128373] linearizableReadLoop","detail":"{readStateIndex:24641; appliedIndex:24639; }","duration":"130.534355ms","start":"2026-05-09T17:39:45.838281Z","end":"2026-05-09T17:39:45.968815Z","steps":["trace[1967128373] 'read index received'  (duration: 124.311526ms)","trace[1967128373] 'applied index is now lower than readState.Index'  (duration: 6.221879ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:45.968852Z","caller":"traceutil/trace.go:171","msg":"trace[417806339] transaction","detail":"{read_only:false; response_revision:23870; number_of_response:1; }","duration":"135.986243ms","start":"2026-05-09T17:39:45.832837Z","end":"2026-05-09T17:39:45.968823Z","steps":["trace[417806339] 'process raft request'  (duration: 129.770255ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:45.969031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.738921ms","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-09T17:39:45.969074Z","caller":"traceutil/trace.go:171","msg":"trace[1349123355] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23871; }","duration":"130.826503ms","start":"2026-05-09T17:39:45.838237Z","end":"2026-05-09T17:39:45.969063Z","steps":["trace[1349123355] 'agreement among raft nodes before linearized reading'  (duration: 130.685439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:45.969661Z","caller":"traceutil/trace.go:171","msg":"trace[68108001] transaction","detail":"{read_only:false; response_revision:23871; number_of_response:1; }","duration":"135.490629ms","start":"2026-05-09T17:39:45.834146Z","end":"2026-05-09T17:39:45.969636Z","steps":["trace[68108001] 'process raft request'  (duration: 134.619466ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:46.590973Z","caller":"traceutil/trace.go:171","msg":"trace[1062809404] linearizableReadLoop","detail":"{readStateIndex:24643; appliedIndex:24642; }","duration":"197.098892ms","start":"2026-05-09T17:39:46.393851Z","end":"2026-05-09T17:39:46.59095Z","steps":["trace[1062809404] 'read index received'  (duration: 196.801934ms)","trace[1062809404] 'applied index is now lower than readState.Index'  (duration: 295.598µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:46.591082Z","caller":"traceutil/trace.go:171","msg":"trace[1205248076] transaction","detail":"{read_only:false; response_revision:23873; number_of_response:1; }","duration":"199.511928ms","start":"2026-05-09T17:39:46.391533Z","end":"2026-05-09T17:39:46.591044Z","steps":["trace[1205248076] 'process raft request'  (duration: 199.2165ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:46.591229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.65235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:39:46.591292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.416281ms","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-09T17:39:46.591301Z","caller":"traceutil/trace.go:171","msg":"trace[383502622] 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:23873; }","duration":"168.785643ms","start":"2026-05-09T17:39:46.422499Z","end":"2026-05-09T17:39:46.591284Z","steps":["trace[383502622] 'agreement among raft nodes before linearized reading'  (duration: 168.65133ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:46.591291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.094873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:39:46.59136Z","caller":"traceutil/trace.go:171","msg":"trace[1904044328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23873; }","duration":"123.209676ms","start":"2026-05-09T17:39:46.468133Z","end":"2026-05-09T17:39:46.591342Z","steps":["trace[1904044328] 'agreement among raft nodes before linearized reading'  (duration: 123.034691ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:46.59134Z","caller":"traceutil/trace.go:171","msg":"trace[1014669483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23873; }","duration":"197.511763ms","start":"2026-05-09T17:39:46.393817Z","end":"2026-05-09T17:39:46.591328Z","steps":["trace[1014669483] 'agreement among raft nodes before linearized reading'  (duration: 197.271827ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:46.902033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.355622ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056794 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23862 > 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-09T17:39:46.902203Z","caller":"traceutil/trace.go:171","msg":"trace[621258108] transaction","detail":"{read_only:false; response_revision:23876; number_of_response:1; }","duration":"231.966029ms","start":"2026-05-09T17:39:46.67022Z","end":"2026-05-09T17:39:46.902186Z","steps":["trace[621258108] 'process raft request'  (duration: 231.910987ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:46.902356Z","caller":"traceutil/trace.go:171","msg":"trace[864692915] transaction","detail":"{read_only:false; response_revision:23875; number_of_response:1; }","duration":"306.604845ms","start":"2026-05-09T17:39:46.595712Z","end":"2026-05-09T17:39:46.902317Z","steps":["trace[864692915] 'process raft request'  (duration: 144.882414ms)","trace[864692915] 'compare'  (duration: 161.243179ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:46.90242Z","caller":"traceutil/trace.go:171","msg":"trace[244771134] linearizableReadLoop","detail":"{readStateIndex:24645; appliedIndex:24643; }","duration":"305.870956ms","start":"2026-05-09T17:39:46.596501Z","end":"2026-05-09T17:39:46.902372Z","steps":["trace[244771134] 'read index received'  (duration: 16.316633ms)","trace[244771134] 'applied index is now lower than readState.Index'  (duration: 289.548463ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:46.902548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:46.595687Z","time spent":"306.75492ms","remote":"127.0.0.1:50698","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:23862 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-09T17:39:46.902648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.141124ms","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-09T17:39:46.902706Z","caller":"traceutil/trace.go:171","msg":"trace[275583040] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:23876; }","duration":"306.243506ms","start":"2026-05-09T17:39:46.596447Z","end":"2026-05-09T17:39:46.902691Z","steps":["trace[275583040] 'agreement among raft nodes before linearized reading'  (duration: 306.144814ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:46.902684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.130514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:39:46.902745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:46.596427Z","time spent":"306.308848ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"info","ts":"2026-05-09T17:39:46.902764Z","caller":"traceutil/trace.go:171","msg":"trace[511893574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23876; }","duration":"246.216016ms","start":"2026-05-09T17:39:46.656529Z","end":"2026-05-09T17:39:46.902745Z","steps":["trace[511893574] 'agreement among raft nodes before linearized reading'  (duration: 246.094143ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:47.153069Z","caller":"traceutil/trace.go:171","msg":"trace[1334727999] linearizableReadLoop","detail":"{readStateIndex:24647; appliedIndex:24646; }","duration":"169.322378ms","start":"2026-05-09T17:39:46.983715Z","end":"2026-05-09T17:39:47.153037Z","steps":["trace[1334727999] 'read index received'  (duration: 168.833334ms)","trace[1334727999] 'applied index is now lower than readState.Index'  (duration: 487.884µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:47.153151Z","caller":"traceutil/trace.go:171","msg":"trace[62960010] transaction","detail":"{read_only:false; response_revision:23877; number_of_response:1; }","duration":"193.799742ms","start":"2026-05-09T17:39:46.959307Z","end":"2026-05-09T17:39:47.153106Z","steps":["trace[62960010] 'process raft request'  (duration: 193.34954ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:47.153382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.603027ms","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-09T17:39:47.153465Z","caller":"traceutil/trace.go:171","msg":"trace[1134312134] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:23877; }","duration":"169.792251ms","start":"2026-05-09T17:39:46.983657Z","end":"2026-05-09T17:39:47.15345Z","steps":["trace[1134312134] 'agreement among raft nodes before linearized reading'  (duration: 169.506504ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:47.345853Z","caller":"traceutil/trace.go:171","msg":"trace[1643788461] linearizableReadLoop","detail":"{readStateIndex:24648; appliedIndex:24647; }","duration":"189.347981ms","start":"2026-05-09T17:39:47.156478Z","end":"2026-05-09T17:39:47.345826Z","steps":["trace[1643788461] 'read index received'  (duration: 154.223398ms)","trace[1643788461] 'applied index is now lower than readState.Index'  (duration: 35.123253ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:47.345893Z","caller":"traceutil/trace.go:171","msg":"trace[1248132120] transaction","detail":"{read_only:false; response_revision:23878; number_of_response:1; }","duration":"303.902802ms","start":"2026-05-09T17:39:47.041959Z","end":"2026-05-09T17:39:47.345862Z","steps":["trace[1248132120] 'process raft request'  (duration: 268.802389ms)","trace[1248132120] 'compare'  (duration: 34.793964ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:47.34598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.479486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:47.346017Z","caller":"traceutil/trace.go:171","msg":"trace[1220672824] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:23878; }","duration":"189.534267ms","start":"2026-05-09T17:39:47.156472Z","end":"2026-05-09T17:39:47.346006Z","steps":["trace[1220672824] 'agreement among raft nodes before linearized reading'  (duration: 189.449695ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:47.346041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:47.041921Z","time spent":"304.040007ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23864 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-09T17:39:47.558927Z","caller":"traceutil/trace.go:171","msg":"trace[1051579833] transaction","detail":"{read_only:false; response_revision:23880; number_of_response:1; }","duration":"204.898665ms","start":"2026-05-09T17:39:47.354004Z","end":"2026-05-09T17:39:47.558902Z","steps":["trace[1051579833] 'process raft request'  (duration: 189.911067ms)","trace[1051579833] 'compare'  (duration: 14.629447ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:47.559088Z","caller":"traceutil/trace.go:171","msg":"trace[1526845872] linearizableReadLoop","detail":"{readStateIndex:24651; appliedIndex:24649; }","duration":"156.160721ms","start":"2026-05-09T17:39:47.402902Z","end":"2026-05-09T17:39:47.559063Z","steps":["trace[1526845872] 'read index received'  (duration: 140.977268ms)","trace[1526845872] 'applied index is now lower than readState.Index'  (duration: 15.182263ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:47.559292Z","caller":"traceutil/trace.go:171","msg":"trace[2054970790] transaction","detail":"{read_only:false; response_revision:23881; number_of_response:1; }","duration":"181.058237ms","start":"2026-05-09T17:39:47.378219Z","end":"2026-05-09T17:39:47.559277Z","steps":["trace[2054970790] 'process raft request'  (duration: 180.631045ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:47.559563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.49521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"}
{"level":"info","ts":"2026-05-09T17:39:47.559628Z","caller":"traceutil/trace.go:171","msg":"trace[1255634956] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:23881; }","duration":"156.748187ms","start":"2026-05-09T17:39:47.402865Z","end":"2026-05-09T17:39:47.559613Z","steps":["trace[1255634956] 'agreement among raft nodes before linearized reading'  (duration: 156.413508ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:47.811054Z","caller":"traceutil/trace.go:171","msg":"trace[931073846] linearizableReadLoop","detail":"{readStateIndex:24653; appliedIndex:24651; }","duration":"251.8897ms","start":"2026-05-09T17:39:47.55914Z","end":"2026-05-09T17:39:47.81103Z","steps":["trace[931073846] 'read index received'  (duration: 172.050022ms)","trace[931073846] 'applied index is now lower than readState.Index'  (duration: 79.838888ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:47.811126Z","caller":"traceutil/trace.go:171","msg":"trace[528601311] transaction","detail":"{read_only:false; response_revision:23882; number_of_response:1; }","duration":"271.584835ms","start":"2026-05-09T17:39:47.539506Z","end":"2026-05-09T17:39:47.811091Z","steps":["trace[528601311] 'process raft request'  (duration: 191.739826ms)","trace[528601311] 'compare'  (duration: 79.286743ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:47.811304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.900327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"}
{"level":"warn","ts":"2026-05-09T17:39:47.811325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.081284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"warn","ts":"2026-05-09T17:39:47.811319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.117325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:47.811373Z","caller":"traceutil/trace.go:171","msg":"trace[1255346273] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:23883; }","duration":"235.181896ms","start":"2026-05-09T17:39:47.576179Z","end":"2026-05-09T17:39:47.81136Z","steps":["trace[1255346273] 'agreement among raft nodes before linearized reading'  (duration: 235.003451ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:47.811374Z","caller":"traceutil/trace.go:171","msg":"trace[880137271] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:23883; }","duration":"394.001689ms","start":"2026-05-09T17:39:47.417355Z","end":"2026-05-09T17:39:47.811356Z","steps":["trace[880137271] 'agreement among raft nodes before linearized reading'  (duration: 393.772833ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:47.811388Z","caller":"traceutil/trace.go:171","msg":"trace[1052143871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23883; }","duration":"154.232159ms","start":"2026-05-09T17:39:47.657139Z","end":"2026-05-09T17:39:47.811371Z","steps":["trace[1052143871] 'agreement among raft nodes before linearized reading'  (duration: 154.095445ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:47.811418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:47.417348Z","time spent":"394.061902ms","remote":"127.0.0.1:50586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18391,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-05-09T17:39:47.811707Z","caller":"traceutil/trace.go:171","msg":"trace[1082180083] transaction","detail":"{read_only:false; response_revision:23883; number_of_response:1; }","duration":"270.697971ms","start":"2026-05-09T17:39:47.54099Z","end":"2026-05-09T17:39:47.811688Z","steps":["trace[1082180083] 'process raft request'  (duration: 269.941291ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:48.105138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.922923ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056819 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:23869 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:39:48.105237Z","caller":"traceutil/trace.go:171","msg":"trace[492363910] linearizableReadLoop","detail":"{readStateIndex:24654; appliedIndex:24653; }","duration":"139.295003ms","start":"2026-05-09T17:39:47.965926Z","end":"2026-05-09T17:39:48.105221Z","steps":["trace[492363910] 'read index received'  (duration: 51.061µs)","trace[492363910] 'applied index is now lower than readState.Index'  (duration: 139.242732ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:48.105531Z","caller":"traceutil/trace.go:171","msg":"trace[828501568] transaction","detail":"{read_only:false; response_revision:23884; number_of_response:1; }","duration":"267.161915ms","start":"2026-05-09T17:39:47.83835Z","end":"2026-05-09T17:39:48.105511Z","steps":["trace[828501568] 'process raft request'  (duration: 113.828131ms)","trace[828501568] 'compare'  (duration: 152.152711ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:48.105814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.872949ms","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-09T17:39:48.105866Z","caller":"traceutil/trace.go:171","msg":"trace[1216569327] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:23884; }","duration":"139.969711ms","start":"2026-05-09T17:39:47.965879Z","end":"2026-05-09T17:39:48.105849Z","steps":["trace[1216569327] 'agreement among raft nodes before linearized reading'  (duration: 139.877439ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:48.106107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.752506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T17:39:48.106136Z","caller":"traceutil/trace.go:171","msg":"trace[560714834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23884; }","duration":"132.797067ms","start":"2026-05-09T17:39:47.973331Z","end":"2026-05-09T17:39:48.106128Z","steps":["trace[560714834] 'agreement among raft nodes before linearized reading'  (duration: 132.692594ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:48.106356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.793445ms","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-09T17:39:48.106376Z","caller":"traceutil/trace.go:171","msg":"trace[1882636161] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23884; }","duration":"125.831567ms","start":"2026-05-09T17:39:47.980539Z","end":"2026-05-09T17:39:48.10637Z","steps":["trace[1882636161] 'agreement among raft nodes before linearized reading'  (duration: 125.769825ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:48.106487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.863538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-09T17:39:48.106507Z","caller":"traceutil/trace.go:171","msg":"trace[491383264] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23884; }","duration":"132.897508ms","start":"2026-05-09T17:39:47.973603Z","end":"2026-05-09T17:39:48.1065Z","steps":["trace[491383264] 'agreement among raft nodes before linearized reading'  (duration: 132.847927ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:48.257469Z","caller":"traceutil/trace.go:171","msg":"trace[2113225398] transaction","detail":"{read_only:false; response_revision:23886; number_of_response:1; }","duration":"146.449166ms","start":"2026-05-09T17:39:48.110995Z","end":"2026-05-09T17:39:48.257445Z","steps":["trace[2113225398] 'process raft request'  (duration: 140.977998ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:48.257895Z","caller":"traceutil/trace.go:171","msg":"trace[1389437768] transaction","detail":"{read_only:false; response_revision:23887; number_of_response:1; }","duration":"146.482888ms","start":"2026-05-09T17:39:48.111387Z","end":"2026-05-09T17:39:48.257869Z","steps":["trace[1389437768] 'process raft request'  (duration: 145.993405ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:48.740627Z","caller":"traceutil/trace.go:171","msg":"trace[1166685951] linearizableReadLoop","detail":"{readStateIndex:24659; appliedIndex:24657; }","duration":"123.595006ms","start":"2026-05-09T17:39:48.61701Z","end":"2026-05-09T17:39:48.740605Z","steps":["trace[1166685951] 'read index received'  (duration: 111.802406ms)","trace[1166685951] 'applied index is now lower than readState.Index'  (duration: 11.79102ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:48.740828Z","caller":"traceutil/trace.go:171","msg":"trace[519895799] transaction","detail":"{read_only:false; response_revision:23888; number_of_response:1; }","duration":"142.987433ms","start":"2026-05-09T17:39:48.597735Z","end":"2026-05-09T17:39:48.740722Z","steps":["trace[519895799] 'process raft request'  (duration: 142.723956ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:48.74092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.895484ms","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-09T17:39:48.740997Z","caller":"traceutil/trace.go:171","msg":"trace[20692201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23888; }","duration":"123.989007ms","start":"2026-05-09T17:39:48.616987Z","end":"2026-05-09T17:39:48.740976Z","steps":["trace[20692201] 'agreement among raft nodes before linearized reading'  (duration: 123.75034ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:48.854049Z","caller":"traceutil/trace.go:171","msg":"trace[538848819] transaction","detail":"{read_only:false; response_revision:23889; number_of_response:1; }","duration":"111.617151ms","start":"2026-05-09T17:39:48.742402Z","end":"2026-05-09T17:39:48.854019Z","steps":["trace[538848819] 'process raft request'  (duration: 111.420306ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:49.087693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.893418ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056836 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:23874 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:39:49.087879Z","caller":"traceutil/trace.go:171","msg":"trace[1504224457] linearizableReadLoop","detail":"{readStateIndex:24661; appliedIndex:24660; }","duration":"180.869201ms","start":"2026-05-09T17:39:48.906984Z","end":"2026-05-09T17:39:49.087853Z","steps":["trace[1504224457] 'read index received'  (duration: 75.716286ms)","trace[1504224457] 'applied index is now lower than readState.Index'  (duration: 105.151095ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:49.087884Z","caller":"traceutil/trace.go:171","msg":"trace[779105287] transaction","detail":"{read_only:false; response_revision:23890; number_of_response:1; }","duration":"342.882891ms","start":"2026-05-09T17:39:48.744963Z","end":"2026-05-09T17:39:49.087846Z","steps":["trace[779105287] 'process raft request'  (duration: 237.722836ms)","trace[779105287] 'compare'  (duration: 104.670432ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:49.088066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.090706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-05-09T17:39:49.088067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:48.744922Z","time spent":"343.038725ms","remote":"127.0.0.1:50698","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:23874 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T17:39:49.088111Z","caller":"traceutil/trace.go:171","msg":"trace[1736509960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23890; }","duration":"181.127397ms","start":"2026-05-09T17:39:48.906965Z","end":"2026-05-09T17:39:49.088092Z","steps":["trace[1736509960] 'agreement among raft nodes before linearized reading'  (duration: 180.958383ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:49.132852Z","caller":"traceutil/trace.go:171","msg":"trace[1102851941] transaction","detail":"{read_only:false; response_revision:23891; number_of_response:1; }","duration":"224.846185ms","start":"2026-05-09T17:39:48.907979Z","end":"2026-05-09T17:39:49.132825Z","steps":["trace[1102851941] 'process raft request'  (duration: 224.678421ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:49.273886Z","caller":"traceutil/trace.go:171","msg":"trace[199348650] transaction","detail":"{read_only:false; response_revision:23892; number_of_response:1; }","duration":"181.430727ms","start":"2026-05-09T17:39:49.092428Z","end":"2026-05-09T17:39:49.273859Z","steps":["trace[199348650] 'process raft request'  (duration: 167.620952ms)","trace[199348650] 'compare'  (duration: 13.688191ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:49.600749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.230096ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056840 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23878 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:39:49.600864Z","caller":"traceutil/trace.go:171","msg":"trace[1764330000] linearizableReadLoop","detail":"{readStateIndex:24664; appliedIndex:24663; }","duration":"201.12084ms","start":"2026-05-09T17:39:49.399724Z","end":"2026-05-09T17:39:49.600845Z","steps":["trace[1764330000] 'read index received'  (duration: 42.680398ms)","trace[1764330000] 'applied index is now lower than readState.Index'  (duration: 158.439182ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:49.600945Z","caller":"traceutil/trace.go:171","msg":"trace[1898258684] transaction","detail":"{read_only:false; response_revision:23893; number_of_response:1; }","duration":"249.798943ms","start":"2026-05-09T17:39:49.351134Z","end":"2026-05-09T17:39:49.600933Z","steps":["trace[1898258684] 'process raft request'  (duration: 91.291449ms)","trace[1898258684] 'compare'  (duration: 158.107263ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:49.601202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.460571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/trunks/\" range_end:\"/registry/openstack.k-orc.cloud/trunks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:49.601316Z","caller":"traceutil/trace.go:171","msg":"trace[2062910181] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/trunks/; range_end:/registry/openstack.k-orc.cloud/trunks0; response_count:0; response_revision:23893; }","duration":"201.634095ms","start":"2026-05-09T17:39:49.39966Z","end":"2026-05-09T17:39:49.601294Z","steps":["trace[2062910181] 'agreement among raft nodes before linearized reading'  (duration: 201.43675ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:49.601709Z","caller":"traceutil/trace.go:171","msg":"trace[1676793843] transaction","detail":"{read_only:false; response_revision:23894; number_of_response:1; }","duration":"195.506839ms","start":"2026-05-09T17:39:49.406187Z","end":"2026-05-09T17:39:49.601694Z","steps":["trace[1676793843] 'process raft request'  (duration: 195.428607ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:49.61444Z","caller":"traceutil/trace.go:171","msg":"trace[924855009] transaction","detail":"{read_only:false; response_revision:23895; number_of_response:1; }","duration":"166.186292ms","start":"2026-05-09T17:39:49.448232Z","end":"2026-05-09T17:39:49.614418Z","steps":["trace[924855009] 'process raft request'  (duration: 165.909885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:49.88667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.95963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:49.886757Z","caller":"traceutil/trace.go:171","msg":"trace[482946500] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:23896; }","duration":"168.117986ms","start":"2026-05-09T17:39:49.718621Z","end":"2026-05-09T17:39:49.886739Z","steps":["trace[482946500] 'count revisions from in-memory index tree'  (duration: 167.852317ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:50.160766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.746535ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056851 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23883 > 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-09T17:39:50.160872Z","caller":"traceutil/trace.go:171","msg":"trace[633254262] linearizableReadLoop","detail":"{readStateIndex:24669; appliedIndex:24667; }","duration":"285.839782ms","start":"2026-05-09T17:39:49.875014Z","end":"2026-05-09T17:39:50.160854Z","steps":["trace[633254262] 'read index received'  (duration: 18.146373ms)","trace[633254262] 'applied index is now lower than readState.Index'  (duration: 267.691939ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:50.161059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.031037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:50.16115Z","caller":"traceutil/trace.go:171","msg":"trace[16511327] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:23898; }","duration":"286.161501ms","start":"2026-05-09T17:39:49.874956Z","end":"2026-05-09T17:39:50.161118Z","steps":["trace[16511327] 'agreement among raft nodes before linearized reading'  (duration: 286.005966ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:50.161166Z","caller":"traceutil/trace.go:171","msg":"trace[474065415] transaction","detail":"{read_only:false; response_revision:23898; number_of_response:1; }","duration":"344.608148ms","start":"2026-05-09T17:39:49.816509Z","end":"2026-05-09T17:39:50.161117Z","steps":["trace[474065415] 'process raft request'  (duration: 204.418131ms)","trace[474065415] 'compare'  (duration: 139.308463ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:50.161594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:49.81649Z","time spent":"344.919237ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23883 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T17:39:50.431307Z","caller":"traceutil/trace.go:171","msg":"trace[356845463] linearizableReadLoop","detail":"{readStateIndex:24671; appliedIndex:24670; }","duration":"216.19185ms","start":"2026-05-09T17:39:50.215083Z","end":"2026-05-09T17:39:50.431275Z","steps":["trace[356845463] 'read index received'  (duration: 214.635288ms)","trace[356845463] 'applied index is now lower than readState.Index'  (duration: 1.555062ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:50.431421Z","caller":"traceutil/trace.go:171","msg":"trace[853307435] transaction","detail":"{read_only:false; response_revision:23900; number_of_response:1; }","duration":"265.48094ms","start":"2026-05-09T17:39:50.16592Z","end":"2026-05-09T17:39:50.431401Z","steps":["trace[853307435] 'process raft request'  (duration: 263.857775ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:50.431569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.665703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:531"}
{"level":"warn","ts":"2026-05-09T17:39:50.431607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.441017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T17:39:50.431666Z","caller":"traceutil/trace.go:171","msg":"trace[1558043846] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:23900; }","duration":"206.789195ms","start":"2026-05-09T17:39:50.224854Z","end":"2026-05-09T17:39:50.431643Z","steps":["trace[1558043846] 'agreement among raft nodes before linearized reading'  (duration: 206.57857ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:50.431707Z","caller":"traceutil/trace.go:171","msg":"trace[1566692022] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:23900; }","duration":"216.654923ms","start":"2026-05-09T17:39:50.215034Z","end":"2026-05-09T17:39:50.431689Z","steps":["trace[1566692022] 'agreement among raft nodes before linearized reading'  (duration: 216.370645ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:50.43174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.955176ms","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-09T17:39:50.431829Z","caller":"traceutil/trace.go:171","msg":"trace[2031991836] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23900; }","duration":"170.086879ms","start":"2026-05-09T17:39:50.261725Z","end":"2026-05-09T17:39:50.431812Z","steps":["trace[2031991836] 'agreement among raft nodes before linearized reading'  (duration: 169.802431ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:50.431818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.418948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-09T17:39:50.432243Z","caller":"traceutil/trace.go:171","msg":"trace[1662577983] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23900; }","duration":"170.879211ms","start":"2026-05-09T17:39:50.261333Z","end":"2026-05-09T17:39:50.432212Z","steps":["trace[1662577983] 'agreement among raft nodes before linearized reading'  (duration: 170.287875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:50.70966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.578341ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056859 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23887 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:39:50.709874Z","caller":"traceutil/trace.go:171","msg":"trace[270640905] transaction","detail":"{read_only:false; response_revision:23902; number_of_response:1; }","duration":"268.388028ms","start":"2026-05-09T17:39:50.441445Z","end":"2026-05-09T17:39:50.709833Z","steps":["trace[270640905] 'process raft request'  (duration: 142.55869ms)","trace[270640905] 'compare'  (duration: 125.214661ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:50.709894Z","caller":"traceutil/trace.go:171","msg":"trace[2118508030] transaction","detail":"{read_only:false; response_revision:23903; number_of_response:1; }","duration":"268.335836ms","start":"2026-05-09T17:39:50.441514Z","end":"2026-05-09T17:39:50.709849Z","steps":["trace[2118508030] 'process raft request'  (duration: 268.249144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:50.907616Z","caller":"traceutil/trace.go:171","msg":"trace[1295540544] transaction","detail":"{read_only:false; response_revision:23904; number_of_response:1; }","duration":"160.18563ms","start":"2026-05-09T17:39:50.747283Z","end":"2026-05-09T17:39:50.907469Z","steps":["trace[1295540544] 'process raft request'  (duration: 98.7111ms)","trace[1295540544] 'compare'  (duration: 61.277894ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:51.149753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.200444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:51.149872Z","caller":"traceutil/trace.go:171","msg":"trace[1975811110] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:23904; }","duration":"127.378088ms","start":"2026-05-09T17:39:51.022467Z","end":"2026-05-09T17:39:51.149845Z","steps":["trace[1975811110] 'count revisions from in-memory index tree'  (duration: 127.087711ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:51.444147Z","caller":"traceutil/trace.go:171","msg":"trace[1870613923] transaction","detail":"{read_only:false; response_revision:23905; number_of_response:1; }","duration":"306.222565ms","start":"2026-05-09T17:39:51.1379Z","end":"2026-05-09T17:39:51.444123Z","steps":["trace[1870613923] 'process raft request'  (duration: 306.065341ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:51.444296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:51.137883Z","time spent":"306.331838ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"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:23891 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:504 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-09T17:39:51.462866Z","caller":"traceutil/trace.go:171","msg":"trace[739479885] transaction","detail":"{read_only:false; response_revision:23906; number_of_response:1; }","duration":"308.874257ms","start":"2026-05-09T17:39:51.153977Z","end":"2026-05-09T17:39:51.462851Z","steps":["trace[739479885] 'process raft request'  (duration: 307.522991ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:51.462952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:51.153952Z","time spent":"308.9584ms","remote":"127.0.0.1:50698","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:23890 > 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-09T17:39:51.463032Z","caller":"traceutil/trace.go:171","msg":"trace[1110109157] linearizableReadLoop","detail":"{readStateIndex:24677; appliedIndex:24675; }","duration":"223.158799ms","start":"2026-05-09T17:39:51.239855Z","end":"2026-05-09T17:39:51.463014Z","steps":["trace[1110109157] 'read index received'  (duration: 204.143413ms)","trace[1110109157] 'applied index is now lower than readState.Index'  (duration: 19.014196ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:51.46327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.420178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:39:51.463314Z","caller":"traceutil/trace.go:171","msg":"trace[369602491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23907; }","duration":"184.49543ms","start":"2026-05-09T17:39:51.278808Z","end":"2026-05-09T17:39:51.463303Z","steps":["trace[369602491] 'agreement among raft nodes before linearized reading'  (duration: 184.348156ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:51.463342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.322624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:51.463441Z","caller":"traceutil/trace.go:171","msg":"trace[1571428758] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:23907; }","duration":"223.598671ms","start":"2026-05-09T17:39:51.239822Z","end":"2026-05-09T17:39:51.463421Z","steps":["trace[1571428758] 'agreement among raft nodes before linearized reading'  (duration: 223.298983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:51.760686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.255546ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056872 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23893 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:39:51.760795Z","caller":"traceutil/trace.go:171","msg":"trace[904024141] transaction","detail":"{read_only:false; response_revision:23909; number_of_response:1; }","duration":"154.869565ms","start":"2026-05-09T17:39:51.605905Z","end":"2026-05-09T17:39:51.760775Z","steps":["trace[904024141] 'process raft request'  (duration: 52.444734ms)","trace[904024141] 'compare'  (duration: 101.791304ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:52.051905Z","caller":"traceutil/trace.go:171","msg":"trace[185991015] linearizableReadLoop","detail":"{readStateIndex:24682; appliedIndex:24679; }","duration":"393.784123ms","start":"2026-05-09T17:39:51.658097Z","end":"2026-05-09T17:39:52.051881Z","steps":["trace[185991015] 'read index received'  (duration: 242.947µs)","trace[185991015] 'applied index is now lower than readState.Index'  (duration: 393.540256ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:52.052016Z","caller":"traceutil/trace.go:171","msg":"trace[724758918] transaction","detail":"{read_only:false; response_revision:23911; number_of_response:1; }","duration":"432.828483ms","start":"2026-05-09T17:39:51.619178Z","end":"2026-05-09T17:39:52.052006Z","steps":["trace[724758918] 'process raft request'  (duration: 432.659279ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:52.052032Z","caller":"traceutil/trace.go:171","msg":"trace[642499783] transaction","detail":"{read_only:false; response_revision:23910; number_of_response:1; }","duration":"445.259721ms","start":"2026-05-09T17:39:51.606665Z","end":"2026-05-09T17:39:52.051924Z","steps":["trace[642499783] 'process raft request'  (duration: 445.005304ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:52.052115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:51.61915Z","time spent":"432.892584ms","remote":"127.0.0.1:50698","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:23896 > 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-09T17:39:52.052188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:51.606643Z","time spent":"445.459236ms","remote":"127.0.0.1:50698","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:23894 > 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-09T17:39:52.052694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.590935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:52.052775Z","caller":"traceutil/trace.go:171","msg":"trace[1086737237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23911; }","duration":"394.717929ms","start":"2026-05-09T17:39:51.658038Z","end":"2026-05-09T17:39:52.052756Z","steps":["trace[1086737237] 'agreement among raft nodes before linearized reading'  (duration: 394.591395ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:52.052817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:51.658015Z","time spent":"394.790901ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-09T17:39:52.06445Z","caller":"traceutil/trace.go:171","msg":"trace[1425343389] transaction","detail":"{read_only:false; response_revision:23912; number_of_response:1; }","duration":"163.090198ms","start":"2026-05-09T17:39:51.901335Z","end":"2026-05-09T17:39:52.064425Z","steps":["trace[1425343389] 'process raft request'  (duration: 162.933204ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:52.06455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.457573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:52.064596Z","caller":"traceutil/trace.go:171","msg":"trace[1680887400] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:23912; }","duration":"288.543515ms","start":"2026-05-09T17:39:51.776039Z","end":"2026-05-09T17:39:52.064582Z","steps":["trace[1680887400] 'agreement among raft nodes before linearized reading'  (duration: 288.447433ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:52.314436Z","caller":"traceutil/trace.go:171","msg":"trace[289850424] linearizableReadLoop","detail":"{readStateIndex:24684; appliedIndex:24683; }","duration":"125.184499ms","start":"2026-05-09T17:39:52.189233Z","end":"2026-05-09T17:39:52.314418Z","steps":["trace[289850424] 'read index received'  (duration: 79.387916ms)","trace[289850424] 'applied index is now lower than readState.Index'  (duration: 45.795783ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:52.314606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.359884ms","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-09T17:39:52.314646Z","caller":"traceutil/trace.go:171","msg":"trace[293415420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23913; }","duration":"125.432956ms","start":"2026-05-09T17:39:52.189194Z","end":"2026-05-09T17:39:52.314627Z","steps":["trace[293415420] 'agreement among raft nodes before linearized reading'  (duration: 125.304353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:52.314678Z","caller":"traceutil/trace.go:171","msg":"trace[32767994] transaction","detail":"{read_only:false; response_revision:23913; number_of_response:1; }","duration":"145.44795ms","start":"2026-05-09T17:39:52.1692Z","end":"2026-05-09T17:39:52.314648Z","steps":["trace[32767994] 'process raft request'  (duration: 99.39994ms)","trace[32767994] 'compare'  (duration: 45.727961ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:58.656205Z","caller":"traceutil/trace.go:171","msg":"trace[1038919182] transaction","detail":"{read_only:false; response_revision:23954; number_of_response:1; }","duration":"583.772292ms","start":"2026-05-09T17:39:58.0724Z","end":"2026-05-09T17:39:58.656173Z","steps":["trace[1038919182] 'process raft request'  (duration: 583.603958ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:58.656452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.072381Z","time spent":"583.969338ms","remote":"127.0.0.1:50698","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:23939 > 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-09T17:39:59.185513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.519747ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056995 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:23940 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:39:59.185723Z","caller":"traceutil/trace.go:171","msg":"trace[18188502] transaction","detail":"{read_only:false; response_revision:23955; number_of_response:1; }","duration":"1.111690628s","start":"2026-05-09T17:39:58.073998Z","end":"2026-05-09T17:39:59.185688Z","steps":["trace[18188502] 'process raft request'  (duration: 812.915535ms)","trace[18188502] 'compare'  (duration: 298.318851ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:39:59.185802Z","caller":"traceutil/trace.go:171","msg":"trace[190983065] transaction","detail":"{read_only:false; response_revision:23956; number_of_response:1; }","duration":"1.100996607s","start":"2026-05-09T17:39:58.08477Z","end":"2026-05-09T17:39:59.185767Z","steps":["trace[190983065] 'process raft request'  (duration: 1.100836433s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.185884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.073972Z","time spent":"1.111821222s","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:23940 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T17:39:59.185899Z","caller":"traceutil/trace.go:171","msg":"trace[1464225903] transaction","detail":"{read_only:false; response_revision:23957; number_of_response:1; }","duration":"854.475723ms","start":"2026-05-09T17:39:58.3314Z","end":"2026-05-09T17:39:59.185876Z","steps":["trace[1464225903] 'process raft request'  (duration: 854.257637ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.185973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.331376Z","time spent":"854.567816ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23942 > 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-09T17:39:59.185968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.084745Z","time spent":"1.101142981s","remote":"127.0.0.1:50698","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:23941 > 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":"warn","ts":"2026-05-09T17:39:59.499628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.911565ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188056998 > lease_revoke:<id:3e739e0da97548a3>","response":"size:29"}
{"level":"info","ts":"2026-05-09T17:39:59.49987Z","caller":"traceutil/trace.go:171","msg":"trace[1322494820] transaction","detail":"{read_only:false; response_revision:23958; number_of_response:1; }","duration":"632.446184ms","start":"2026-05-09T17:39:58.867409Z","end":"2026-05-09T17:39:59.499856Z","steps":["trace[1322494820] 'process raft request'  (duration: 632.324211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.499809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.322716ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:59.499921Z","caller":"traceutil/trace.go:171","msg":"trace[1098653452] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:23957; }","duration":"254.44435ms","start":"2026-05-09T17:39:59.245461Z","end":"2026-05-09T17:39:59.499905Z","steps":["trace[1098653452] 'range keys from in-memory index tree'  (duration: 254.310136ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:59.499923Z","caller":"traceutil/trace.go:171","msg":"trace[1528055576] linearizableReadLoop","detail":"{readStateIndex:24729; appliedIndex:24725; }","duration":"1.141559189s","start":"2026-05-09T17:39:58.358335Z","end":"2026-05-09T17:39:59.499894Z","steps":["trace[1528055576] 'read index received'  (duration: 297.713525ms)","trace[1528055576] 'applied index is now lower than readState.Index'  (duration: 843.843624ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:39:59.499963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.867385Z","time spent":"632.519927ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:23925 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T17:39:59.500643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142283819s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T17:39:59.500752Z","caller":"traceutil/trace.go:171","msg":"trace[730284923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23958; }","duration":"1.142441393s","start":"2026-05-09T17:39:58.358289Z","end":"2026-05-09T17:39:59.50073Z","steps":["trace[730284923] 'agreement among raft nodes before linearized reading'  (duration: 1.141692213s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.500849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.35827Z","time spent":"1.142524054s","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-09T17:39:59.506137Z","caller":"traceutil/trace.go:171","msg":"trace[470163403] transaction","detail":"{read_only:false; response_revision:23959; number_of_response:1; }","duration":"567.412558ms","start":"2026-05-09T17:39:58.938697Z","end":"2026-05-09T17:39:59.50611Z","steps":["trace[470163403] 'process raft request'  (duration: 567.252244ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.506295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.938677Z","time spent":"567.536421ms","remote":"127.0.0.1:50698","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:23947 > 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":"warn","ts":"2026-05-09T17:39:59.526131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.7416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"warn","ts":"2026-05-09T17:39:59.526211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.053816256s","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-09T17:39:59.526193Z","caller":"traceutil/trace.go:171","msg":"trace[543804812] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23961; }","duration":"766.846724ms","start":"2026-05-09T17:39:58.759328Z","end":"2026-05-09T17:39:59.526174Z","steps":["trace[543804812] 'agreement among raft nodes before linearized reading'  (duration: 766.678969ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:59.52627Z","caller":"traceutil/trace.go:171","msg":"trace[1245280769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23961; }","duration":"1.053914179s","start":"2026-05-09T17:39:58.472341Z","end":"2026-05-09T17:39:59.526255Z","steps":["trace[1245280769] 'agreement among raft nodes before linearized reading'  (duration: 1.053785825s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.526306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.472323Z","time spent":"1.053972982s","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T17:39:59.526308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.759308Z","time spent":"766.987458ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-09T17:39:59.526281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.667178ms","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-09T17:39:59.526294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.093141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T17:39:59.526355Z","caller":"traceutil/trace.go:171","msg":"trace[648729698] 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:23961; }","duration":"717.777242ms","start":"2026-05-09T17:39:58.808566Z","end":"2026-05-09T17:39:59.526343Z","steps":["trace[648729698] 'agreement among raft nodes before linearized reading'  (duration: 717.654648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:59.526373Z","caller":"traceutil/trace.go:171","msg":"trace[64782658] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:23961; }","duration":"714.231575ms","start":"2026-05-09T17:39:58.812121Z","end":"2026-05-09T17:39:59.526353Z","steps":["trace[64782658] 'agreement among raft nodes before linearized reading'  (duration: 714.05108ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.526419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.8121Z","time spent":"714.309167ms","remote":"127.0.0.1:50934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":38,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:39:59.526411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.808551Z","time spent":"717.851214ms","remote":"127.0.0.1:55056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:39:59.526449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.241163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274197"}
{"level":"info","ts":"2026-05-09T17:39:59.526513Z","caller":"traceutil/trace.go:171","msg":"trace[1979021759] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:23961; }","duration":"585.355975ms","start":"2026-05-09T17:39:58.941142Z","end":"2026-05-09T17:39:59.526498Z","steps":["trace[1979021759] 'agreement among raft nodes before linearized reading'  (duration: 584.922833ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.526557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.941111Z","time spent":"585.436198ms","remote":"127.0.0.1:50886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":32,"response size":274220,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"warn","ts":"2026-05-09T17:39:59.526631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.075171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:39:59.526688Z","caller":"traceutil/trace.go:171","msg":"trace[80088812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23961; }","duration":"869.165463ms","start":"2026-05-09T17:39:58.657511Z","end":"2026-05-09T17:39:59.526676Z","steps":["trace[80088812] 'agreement among raft nodes before linearized reading'  (duration: 869.06473ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.526733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.657487Z","time spent":"869.238475ms","remote":"127.0.0.1:50420","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-09T17:39:59.526964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031217593s","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-09T17:39:59.527119Z","caller":"traceutil/trace.go:171","msg":"trace[752735293] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23961; }","duration":"1.031376367s","start":"2026-05-09T17:39:58.495681Z","end":"2026-05-09T17:39:59.527057Z","steps":["trace[752735293] 'agreement among raft nodes before linearized reading'  (duration: 1.030856663s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.52721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:58.495619Z","time spent":"1.031578612s","remote":"127.0.0.1:50698","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":"info","ts":"2026-05-09T17:39:59.919571Z","caller":"traceutil/trace.go:171","msg":"trace[2105393850] transaction","detail":"{read_only:false; response_revision:23963; number_of_response:1; }","duration":"388.461419ms","start":"2026-05-09T17:39:59.531078Z","end":"2026-05-09T17:39:59.91954Z","steps":["trace[2105393850] 'process raft request'  (duration: 383.082613ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:59.919618Z","caller":"traceutil/trace.go:171","msg":"trace[1368212390] transaction","detail":"{read_only:false; response_revision:23964; number_of_response:1; }","duration":"388.473149ms","start":"2026-05-09T17:39:59.531113Z","end":"2026-05-09T17:39:59.919586Z","steps":["trace[1368212390] 'process raft request'  (duration: 388.322555ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:39:59.919666Z","caller":"traceutil/trace.go:171","msg":"trace[19097103] transaction","detail":"{read_only:false; response_revision:23967; number_of_response:1; }","duration":"133.703511ms","start":"2026-05-09T17:39:59.78594Z","end":"2026-05-09T17:39:59.919643Z","steps":["trace[19097103] 'process raft request'  (duration: 133.66729ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.919769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:59.531064Z","time spent":"388.587522ms","remote":"127.0.0.1:50698","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:23945 > 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-09T17:39:59.919782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:59.531096Z","time spent":"388.587282ms","remote":"127.0.0.1:50698","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:23944 > 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-09T17:39:59.919815Z","caller":"traceutil/trace.go:171","msg":"trace[2099595031] transaction","detail":"{read_only:false; response_revision:23966; number_of_response:1; }","duration":"388.058218ms","start":"2026-05-09T17:39:59.531722Z","end":"2026-05-09T17:39:59.919781Z","steps":["trace[2099595031] 'process raft request'  (duration: 387.837942ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.920143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:59.531715Z","time spent":"388.186632ms","remote":"127.0.0.1:50698","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:23950 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T17:39:59.919798Z","caller":"traceutil/trace.go:171","msg":"trace[712641082] transaction","detail":"{read_only:false; response_revision:23965; number_of_response:1; }","duration":"388.237823ms","start":"2026-05-09T17:39:59.531528Z","end":"2026-05-09T17:39:59.919766Z","steps":["trace[712641082] 'process raft request'  (duration: 387.995407ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:39:59.920395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:39:59.531504Z","time spent":"388.834979ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23946 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T17:40:03.529772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.964797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:03.529863Z","caller":"traceutil/trace.go:171","msg":"trace[805042336] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24000; }","duration":"124.10712ms","start":"2026-05-09T17:40:03.405734Z","end":"2026-05-09T17:40:03.529841Z","steps":["trace[805042336] 'count revisions from in-memory index tree'  (duration: 123.884845ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:03.530363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.63273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:03.530406Z","caller":"traceutil/trace.go:171","msg":"trace[620291521] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:24000; }","duration":"171.699072ms","start":"2026-05-09T17:40:03.358694Z","end":"2026-05-09T17:40:03.530393Z","steps":["trace[620291521] 'count revisions from in-memory index tree'  (duration: 171.571729ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:03.530671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.458572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:03.530711Z","caller":"traceutil/trace.go:171","msg":"trace[832709523] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:24000; }","duration":"155.499893ms","start":"2026-05-09T17:40:03.375201Z","end":"2026-05-09T17:40:03.530701Z","steps":["trace[832709523] 'count revisions from in-memory index tree'  (duration: 155.39817ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:03.530806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.201818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:03.530878Z","caller":"traceutil/trace.go:171","msg":"trace[1396534983] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24000; }","duration":"231.333323ms","start":"2026-05-09T17:40:03.299524Z","end":"2026-05-09T17:40:03.530858Z","steps":["trace[1396534983] 'count revisions from in-memory index tree'  (duration: 231.092386ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:03.772718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.97734ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188057102 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:3e739e0da9754a0d>","response":"size:41"}
{"level":"info","ts":"2026-05-09T17:40:03.772979Z","caller":"traceutil/trace.go:171","msg":"trace[1301087095] linearizableReadLoop","detail":"{readStateIndex:24777; appliedIndex:24774; }","duration":"218.834892ms","start":"2026-05-09T17:40:03.554122Z","end":"2026-05-09T17:40:03.772957Z","steps":["trace[1301087095] 'read index received'  (duration: 13.720583ms)","trace[1301087095] 'applied index is now lower than readState.Index'  (duration: 205.113229ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:03.773335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.451305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:03.773372Z","caller":"traceutil/trace.go:171","msg":"trace[1276789950] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24002; }","duration":"122.533707ms","start":"2026-05-09T17:40:03.650826Z","end":"2026-05-09T17:40:03.77336Z","steps":["trace[1276789950] 'agreement among raft nodes before linearized reading'  (duration: 122.413854ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:03.773386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.018333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:40:03.773367Z","caller":"traceutil/trace.go:171","msg":"trace[790345697] transaction","detail":"{read_only:false; response_revision:24002; number_of_response:1; }","duration":"228.538137ms","start":"2026-05-09T17:40:03.544801Z","end":"2026-05-09T17:40:03.773339Z","steps":["trace[790345697] 'process raft request'  (duration: 228.028022ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:03.773426Z","caller":"traceutil/trace.go:171","msg":"trace[329681871] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24002; }","duration":"214.057304ms","start":"2026-05-09T17:40:03.559355Z","end":"2026-05-09T17:40:03.773413Z","steps":["trace[329681871] 'agreement among raft nodes before linearized reading'  (duration: 213.878669ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:03.773473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.335467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T17:40:03.773556Z","caller":"traceutil/trace.go:171","msg":"trace[1918444724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24002; }","duration":"219.461051ms","start":"2026-05-09T17:40:03.554067Z","end":"2026-05-09T17:40:03.773528Z","steps":["trace[1918444724] 'agreement among raft nodes before linearized reading'  (duration: 219.157183ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:03.956894Z","caller":"traceutil/trace.go:171","msg":"trace[1917381069] transaction","detail":"{read_only:false; response_revision:24005; number_of_response:1; }","duration":"179.191426ms","start":"2026-05-09T17:40:03.777684Z","end":"2026-05-09T17:40:03.956875Z","steps":["trace[1917381069] 'process raft request'  (duration: 179.162925ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:03.957021Z","caller":"traceutil/trace.go:171","msg":"trace[548582103] transaction","detail":"{read_only:false; response_revision:24004; number_of_response:1; }","duration":"179.487444ms","start":"2026-05-09T17:40:03.777509Z","end":"2026-05-09T17:40:03.956996Z","steps":["trace[548582103] 'process raft request'  (duration: 179.233368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:03.957044Z","caller":"traceutil/trace.go:171","msg":"trace[1915296096] linearizableReadLoop","detail":"{readStateIndex:24780; appliedIndex:24780; }","duration":"163.386006ms","start":"2026-05-09T17:40:03.793636Z","end":"2026-05-09T17:40:03.957022Z","steps":["trace[1915296096] 'read index received'  (duration: 163.376746ms)","trace[1915296096] 'applied index is now lower than readState.Index'  (duration: 7.81µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:03.957196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.541881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"}
{"level":"info","ts":"2026-05-09T17:40:03.957235Z","caller":"traceutil/trace.go:171","msg":"trace[1381166013] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24005; }","duration":"163.626422ms","start":"2026-05-09T17:40:03.793598Z","end":"2026-05-09T17:40:03.957225Z","steps":["trace[1381166013] 'agreement among raft nodes before linearized reading'  (duration: 163.52092ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:04.067527Z","caller":"traceutil/trace.go:171","msg":"trace[543046863] transaction","detail":"{read_only:false; response_revision:24008; number_of_response:1; }","duration":"105.565417ms","start":"2026-05-09T17:40:03.961935Z","end":"2026-05-09T17:40:04.067501Z","steps":["trace[543046863] 'process raft request'  (duration: 100.822708ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:04.067753Z","caller":"traceutil/trace.go:171","msg":"trace[1845876617] transaction","detail":"{read_only:false; response_revision:24009; number_of_response:1; }","duration":"105.708291ms","start":"2026-05-09T17:40:03.96203Z","end":"2026-05-09T17:40:04.067739Z","steps":["trace[1845876617] 'process raft request'  (duration: 105.431274ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:04.067895Z","caller":"traceutil/trace.go:171","msg":"trace[839706640] linearizableReadLoop","detail":"{readStateIndex:24785; appliedIndex:24781; }","duration":"105.709591ms","start":"2026-05-09T17:40:03.962161Z","end":"2026-05-09T17:40:04.067871Z","steps":["trace[839706640] 'read index received'  (duration: 63.571356ms)","trace[839706640] 'applied index is now lower than readState.Index'  (duration: 42.136875ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:04.068019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.838344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-09T17:40:04.068023Z","caller":"traceutil/trace.go:171","msg":"trace[1202039906] transaction","detail":"{read_only:false; response_revision:24010; number_of_response:1; }","duration":"105.965057ms","start":"2026-05-09T17:40:03.962039Z","end":"2026-05-09T17:40:04.068004Z","steps":["trace[1202039906] 'process raft request'  (duration: 105.652589ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:04.06805Z","caller":"traceutil/trace.go:171","msg":"trace[1043220976] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24010; }","duration":"105.926726ms","start":"2026-05-09T17:40:03.962113Z","end":"2026-05-09T17:40:04.06804Z","steps":["trace[1043220976] 'agreement among raft nodes before linearized reading'  (duration: 105.843574ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:06.148278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.061921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T17:40:06.148393Z","caller":"traceutil/trace.go:171","msg":"trace[510957113] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:24084; }","duration":"130.242196ms","start":"2026-05-09T17:40:06.018123Z","end":"2026-05-09T17:40:06.148365Z","steps":["trace[510957113] 'count revisions from in-memory index tree'  (duration: 129.913258ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:06.148458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.967193ms","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-09T17:40:06.14854Z","caller":"traceutil/trace.go:171","msg":"trace[1034520136] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24084; }","duration":"118.113067ms","start":"2026-05-09T17:40:06.030408Z","end":"2026-05-09T17:40:06.148521Z","steps":["trace[1034520136] 'range keys from in-memory index tree'  (duration: 117.86245ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:06.439853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.961238ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188057318 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24007 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:06.440256Z","caller":"traceutil/trace.go:171","msg":"trace[1164460498] transaction","detail":"{read_only:false; response_revision:24087; number_of_response:1; }","duration":"286.165722ms","start":"2026-05-09T17:40:06.154065Z","end":"2026-05-09T17:40:06.440231Z","steps":["trace[1164460498] 'process raft request'  (duration: 285.885563ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:06.440244Z","caller":"traceutil/trace.go:171","msg":"trace[645006557] transaction","detail":"{read_only:false; response_revision:24086; number_of_response:1; }","duration":"287.368744ms","start":"2026-05-09T17:40:06.15285Z","end":"2026-05-09T17:40:06.440218Z","steps":["trace[645006557] 'process raft request'  (duration: 110.929532ms)","trace[645006557] 'compare'  (duration: 175.695371ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:06.440436Z","caller":"traceutil/trace.go:171","msg":"trace[1432283763] transaction","detail":"{read_only:false; response_revision:24088; number_of_response:1; }","duration":"285.924224ms","start":"2026-05-09T17:40:06.154502Z","end":"2026-05-09T17:40:06.440426Z","steps":["trace[1432283763] 'process raft request'  (duration: 285.540513ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:08.81848Z","caller":"traceutil/trace.go:171","msg":"trace[1203869549] transaction","detail":"{read_only:false; response_revision:24110; number_of_response:1; }","duration":"131.992534ms","start":"2026-05-09T17:40:08.686462Z","end":"2026-05-09T17:40:08.818455Z","steps":["trace[1203869549] 'process raft request'  (duration: 131.8521ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:11.459004Z","caller":"traceutil/trace.go:171","msg":"trace[1758607783] transaction","detail":"{read_only:false; response_revision:24150; number_of_response:1; }","duration":"231.779914ms","start":"2026-05-09T17:40:11.227196Z","end":"2026-05-09T17:40:11.458976Z","steps":["trace[1758607783] 'process raft request'  (duration: 231.514737ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:11.459066Z","caller":"traceutil/trace.go:171","msg":"trace[1136307366] transaction","detail":"{read_only:false; response_revision:24151; number_of_response:1; }","duration":"231.650211ms","start":"2026-05-09T17:40:11.227374Z","end":"2026-05-09T17:40:11.459024Z","steps":["trace[1136307366] 'process raft request'  (duration: 231.512618ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:41.851543Z","caller":"traceutil/trace.go:171","msg":"trace[1778928433] transaction","detail":"{read_only:false; response_revision:24422; number_of_response:1; }","duration":"294.716783ms","start":"2026-05-09T17:40:41.556802Z","end":"2026-05-09T17:40:41.851519Z","steps":["trace[1778928433] 'process raft request'  (duration: 294.566969ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:41.93905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.419455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:41.939064Z","caller":"traceutil/trace.go:171","msg":"trace[1499835229] transaction","detail":"{read_only:false; response_revision:24424; number_of_response:1; }","duration":"240.980334ms","start":"2026-05-09T17:40:41.698058Z","end":"2026-05-09T17:40:41.939038Z","steps":["trace[1499835229] 'process raft request'  (duration: 214.486865ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:41.925568Z","caller":"traceutil/trace.go:171","msg":"trace[537816325] linearizableReadLoop","detail":"{readStateIndex:25205; appliedIndex:25204; }","duration":"253.990118ms","start":"2026-05-09T17:40:41.658621Z","end":"2026-05-09T17:40:41.912611Z","steps":["trace[537816325] 'read index received'  (duration: 192.882838ms)","trace[537816325] 'applied index is now lower than readState.Index'  (duration: 61.10599ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:41.939123Z","caller":"traceutil/trace.go:171","msg":"trace[1843205483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24424; }","duration":"280.539358ms","start":"2026-05-09T17:40:41.65857Z","end":"2026-05-09T17:40:41.939109Z","steps":["trace[1843205483] 'agreement among raft nodes before linearized reading'  (duration: 280.360113ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:41.939044Z","caller":"traceutil/trace.go:171","msg":"trace[1872742083] transaction","detail":"{read_only:false; response_revision:24423; number_of_response:1; }","duration":"381.079728ms","start":"2026-05-09T17:40:41.557941Z","end":"2026-05-09T17:40:41.939021Z","steps":["trace[1872742083] 'process raft request'  (duration: 354.456506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:41.93961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:41.557918Z","time spent":"381.614443ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24409 > 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-09T17:40:44.057552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.306783ms","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-09T17:40:44.057635Z","caller":"traceutil/trace.go:171","msg":"trace[2059134864] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24438; }","duration":"118.425697ms","start":"2026-05-09T17:40:43.93919Z","end":"2026-05-09T17:40:44.057615Z","steps":["trace[2059134864] 'range keys from in-memory index tree'  (duration: 118.236672ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.057675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.527652ms","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-09T17:40:44.057772Z","caller":"traceutil/trace.go:171","msg":"trace[381326363] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24438; }","duration":"110.677706ms","start":"2026-05-09T17:40:43.947073Z","end":"2026-05-09T17:40:44.057751Z","steps":["trace[381326363] 'count revisions from in-memory index tree'  (duration: 110.45449ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.193155Z","caller":"traceutil/trace.go:171","msg":"trace[892682312] transaction","detail":"{read_only:false; response_revision:24439; number_of_response:1; }","duration":"243.262916ms","start":"2026-05-09T17:40:43.949865Z","end":"2026-05-09T17:40:44.193128Z","steps":["trace[892682312] 'process raft request'  (duration: 243.090201ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.315567Z","caller":"traceutil/trace.go:171","msg":"trace[1916628154] linearizableReadLoop","detail":"{readStateIndex:25224; appliedIndex:25222; }","duration":"254.503702ms","start":"2026-05-09T17:40:44.061043Z","end":"2026-05-09T17:40:44.315547Z","steps":["trace[1916628154] 'read index received'  (duration: 132.609151ms)","trace[1916628154] 'applied index is now lower than readState.Index'  (duration: 121.893671ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:44.315767Z","caller":"traceutil/trace.go:171","msg":"trace[2061059070] transaction","detail":"{read_only:false; response_revision:24441; number_of_response:1; }","duration":"360.549461ms","start":"2026-05-09T17:40:43.955181Z","end":"2026-05-09T17:40:44.31573Z","steps":["trace[2061059070] 'process raft request'  (duration: 360.277884ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.315918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:43.955156Z","time spent":"360.685094ms","remote":"127.0.0.1:50698","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:24425 > 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-09T17:40:44.315937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.838024ms","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-09T17:40:44.315987Z","caller":"traceutil/trace.go:171","msg":"trace[1015585536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24442; }","duration":"182.930257ms","start":"2026-05-09T17:40:44.133044Z","end":"2026-05-09T17:40:44.315974Z","steps":["trace[1015585536] 'agreement among raft nodes before linearized reading'  (duration: 182.762213ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.31605Z","caller":"traceutil/trace.go:171","msg":"trace[512648071] transaction","detail":"{read_only:false; response_revision:24440; number_of_response:1; }","duration":"365.275719ms","start":"2026-05-09T17:40:43.950764Z","end":"2026-05-09T17:40:44.316039Z","steps":["trace[512648071] 'process raft request'  (duration: 364.001664ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.316119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:43.950743Z","time spent":"365.345651ms","remote":"127.0.0.1:50698","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:24424 > 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":"warn","ts":"2026-05-09T17:40:44.31615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.083947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:44.31624Z","caller":"traceutil/trace.go:171","msg":"trace[1637695366] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24442; }","duration":"255.22627ms","start":"2026-05-09T17:40:44.060988Z","end":"2026-05-09T17:40:44.316214Z","steps":["trace[1637695366] 'agreement among raft nodes before linearized reading'  (duration: 255.056576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.316238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.398974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T17:40:44.3163Z","caller":"traceutil/trace.go:171","msg":"trace[520560401] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24442; }","duration":"178.506687ms","start":"2026-05-09T17:40:44.137778Z","end":"2026-05-09T17:40:44.316285Z","steps":["trace[520560401] 'agreement among raft nodes before linearized reading'  (duration: 178.317172ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.315755Z","caller":"traceutil/trace.go:171","msg":"trace[1936344912] transaction","detail":"{read_only:false; response_revision:24442; number_of_response:1; }","duration":"191.82952ms","start":"2026-05-09T17:40:44.123905Z","end":"2026-05-09T17:40:44.315734Z","steps":["trace[1936344912] 'process raft request'  (duration: 191.605234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.610469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.603851ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058140 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24427 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:44.610586Z","caller":"traceutil/trace.go:171","msg":"trace[556149658] transaction","detail":"{read_only:false; response_revision:24443; number_of_response:1; }","duration":"290.637422ms","start":"2026-05-09T17:40:44.319928Z","end":"2026-05-09T17:40:44.610565Z","steps":["trace[556149658] 'process raft request'  (duration: 150.844086ms)","trace[556149658] 'compare'  (duration: 139.453047ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:44.611096Z","caller":"traceutil/trace.go:171","msg":"trace[560338248] linearizableReadLoop","detail":"{readStateIndex:25227; appliedIndex:25225; }","duration":"283.436956ms","start":"2026-05-09T17:40:44.327646Z","end":"2026-05-09T17:40:44.611083Z","steps":["trace[560338248] 'read index received'  (duration: 143.143117ms)","trace[560338248] 'applied index is now lower than readState.Index'  (duration: 140.293099ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:44.611274Z","caller":"traceutil/trace.go:171","msg":"trace[1272724837] transaction","detail":"{read_only:false; response_revision:24444; number_of_response:1; }","duration":"291.116675ms","start":"2026-05-09T17:40:44.320148Z","end":"2026-05-09T17:40:44.611264Z","steps":["trace[1272724837] 'process raft request'  (duration: 290.871189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.611529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.859227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"info","ts":"2026-05-09T17:40:44.611572Z","caller":"traceutil/trace.go:171","msg":"trace[1967004046] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24444; }","duration":"283.9383ms","start":"2026-05-09T17:40:44.327621Z","end":"2026-05-09T17:40:44.611559Z","steps":["trace[1967004046] 'agreement among raft nodes before linearized reading'  (duration: 283.793306ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.857769Z","caller":"traceutil/trace.go:171","msg":"trace[1149996030] linearizableReadLoop","detail":"{readStateIndex:25229; appliedIndex:25227; }","duration":"246.621887ms","start":"2026-05-09T17:40:44.611125Z","end":"2026-05-09T17:40:44.857747Z","steps":["trace[1149996030] 'read index received'  (duration: 150.273901ms)","trace[1149996030] 'applied index is now lower than readState.Index'  (duration: 96.347276ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:44.858Z","caller":"traceutil/trace.go:171","msg":"trace[568273948] transaction","detail":"{read_only:false; response_revision:24445; number_of_response:1; }","duration":"305.059434ms","start":"2026-05-09T17:40:44.552931Z","end":"2026-05-09T17:40:44.857991Z","steps":["trace[568273948] 'process raft request'  (duration: 208.824811ms)","trace[568273948] 'compare'  (duration: 95.652257ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:44.858324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.98926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-09T17:40:44.858365Z","caller":"traceutil/trace.go:171","msg":"trace[2073813546] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:24446; }","duration":"278.056361ms","start":"2026-05-09T17:40:44.580297Z","end":"2026-05-09T17:40:44.858354Z","steps":["trace[2073813546] 'agreement among raft nodes before linearized reading'  (duration: 277.904566ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.858336Z","caller":"traceutil/trace.go:171","msg":"trace[24314718] transaction","detail":"{read_only:false; response_revision:24446; number_of_response:1; }","duration":"295.793782ms","start":"2026-05-09T17:40:44.562506Z","end":"2026-05-09T17:40:44.8583Z","steps":["trace[24314718] 'process raft request'  (duration: 295.188745ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.858378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.800988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-09T17:40:44.858438Z","caller":"traceutil/trace.go:171","msg":"trace[209210893] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24446; }","duration":"244.898601ms","start":"2026-05-09T17:40:44.613519Z","end":"2026-05-09T17:40:44.858417Z","steps":["trace[209210893] 'agreement among raft nodes before linearized reading'  (duration: 244.738995ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.858555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.903597ms","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-09T17:40:44.858582Z","caller":"traceutil/trace.go:171","msg":"trace[1912462557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24446; }","duration":"249.964449ms","start":"2026-05-09T17:40:44.608611Z","end":"2026-05-09T17:40:44.858576Z","steps":["trace[1912462557] 'agreement among raft nodes before linearized reading'  (duration: 249.892637ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.858608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.143646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:40:44.858661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.957402ms","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-09T17:40:44.858657Z","caller":"traceutil/trace.go:171","msg":"trace[1889260530] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:24446; }","duration":"305.213369ms","start":"2026-05-09T17:40:44.55343Z","end":"2026-05-09T17:40:44.858643Z","steps":["trace[1889260530] 'agreement among raft nodes before linearized reading'  (duration: 305.139907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:44.858687Z","caller":"traceutil/trace.go:171","msg":"trace[1885646180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24446; }","duration":"252.020984ms","start":"2026-05-09T17:40:44.60666Z","end":"2026-05-09T17:40:44.858681Z","steps":["trace[1885646180] 'agreement among raft nodes before linearized reading'  (duration: 251.964252ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.858705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:44.553423Z","time spent":"305.26866ms","remote":"127.0.0.1:50550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:40:44.858959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.010361ms","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-09T17:40:44.85902Z","caller":"traceutil/trace.go:171","msg":"trace[79061745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24446; }","duration":"499.084403ms","start":"2026-05-09T17:40:44.359907Z","end":"2026-05-09T17:40:44.858992Z","steps":["trace[79061745] 'agreement among raft nodes before linearized reading'  (duration: 498.98007ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:44.859061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:44.359891Z","time spent":"499.159884ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-09T17:40:44.85808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:44.552909Z","time spent":"305.114355ms","remote":"127.0.0.1:59088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7516,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" mod_revision:23849 > success:<request_put:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" value_size:7458 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" > >"}
{"level":"warn","ts":"2026-05-09T17:40:45.151078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.864644ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058150 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24432 > 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-09T17:40:45.151186Z","caller":"traceutil/trace.go:171","msg":"trace[672631462] transaction","detail":"{read_only:false; response_revision:24448; number_of_response:1; }","duration":"284.869276ms","start":"2026-05-09T17:40:44.866302Z","end":"2026-05-09T17:40:45.151172Z","steps":["trace[672631462] 'process raft request'  (duration: 139.831297ms)","trace[672631462] 'compare'  (duration: 144.773612ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:45.151353Z","caller":"traceutil/trace.go:171","msg":"trace[610478328] transaction","detail":"{read_only:false; response_revision:24449; number_of_response:1; }","duration":"285.03269ms","start":"2026-05-09T17:40:44.866301Z","end":"2026-05-09T17:40:45.151333Z","steps":["trace[610478328] 'process raft request'  (duration: 284.840555ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:45.15146Z","caller":"traceutil/trace.go:171","msg":"trace[1993031543] linearizableReadLoop","detail":"{readStateIndex:25233; appliedIndex:25229; }","duration":"282.757568ms","start":"2026-05-09T17:40:44.868695Z","end":"2026-05-09T17:40:45.151453Z","steps":["trace[1993031543] 'read index received'  (duration: 48.202899ms)","trace[1993031543] 'applied index is now lower than readState.Index'  (duration: 234.554019ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:45.151594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.897042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18368"}
{"level":"info","ts":"2026-05-09T17:40:45.152132Z","caller":"traceutil/trace.go:171","msg":"trace[1938691309] transaction","detail":"{read_only:false; response_revision:24450; number_of_response:1; }","duration":"283.525819ms","start":"2026-05-09T17:40:44.867986Z","end":"2026-05-09T17:40:45.151512Z","steps":["trace[1938691309] 'process raft request'  (duration: 283.284693ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:45.152765Z","caller":"traceutil/trace.go:171","msg":"trace[666724905] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:24450; }","duration":"282.935143ms","start":"2026-05-09T17:40:44.868674Z","end":"2026-05-09T17:40:45.151609Z","steps":["trace[666724905] 'agreement among raft nodes before linearized reading'  (duration: 282.856581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:45.33438Z","caller":"traceutil/trace.go:171","msg":"trace[1783942290] linearizableReadLoop","detail":"{readStateIndex:25234; appliedIndex:25233; }","duration":"182.878256ms","start":"2026-05-09T17:40:45.151478Z","end":"2026-05-09T17:40:45.334356Z","steps":["trace[1783942290] 'read index received'  (duration: 139.17784ms)","trace[1783942290] 'applied index is now lower than readState.Index'  (duration: 43.699416ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:45.334544Z","caller":"traceutil/trace.go:171","msg":"trace[117506594] transaction","detail":"{read_only:false; response_revision:24451; number_of_response:1; }","duration":"397.072843ms","start":"2026-05-09T17:40:44.937463Z","end":"2026-05-09T17:40:45.334536Z","steps":["trace[117506594] 'process raft request'  (duration: 353.290563ms)","trace[117506594] 'compare'  (duration: 43.45098ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:45.334634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:44.937451Z","time spent":"397.114885ms","remote":"127.0.0.1:50698","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:24435 > 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-09T17:40:45.334788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.099225ms","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-09T17:40:45.334817Z","caller":"traceutil/trace.go:171","msg":"trace[922026770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24451; }","duration":"400.159066ms","start":"2026-05-09T17:40:44.93465Z","end":"2026-05-09T17:40:45.334809Z","steps":["trace[922026770] 'agreement among raft nodes before linearized reading'  (duration: 400.106495ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:45.334842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:44.934635Z","time spent":"400.202918ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:40:45.334952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.893355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:45.334974Z","caller":"traceutil/trace.go:171","msg":"trace[2002880012] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:24451; }","duration":"172.943596ms","start":"2026-05-09T17:40:45.162025Z","end":"2026-05-09T17:40:45.334969Z","steps":["trace[2002880012] 'agreement among raft nodes before linearized reading'  (duration: 172.912065ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:45.776724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.747995ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058156 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24436 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:45.776854Z","caller":"traceutil/trace.go:171","msg":"trace[1057950480] linearizableReadLoop","detail":"{readStateIndex:25235; appliedIndex:25234; }","duration":"365.220748ms","start":"2026-05-09T17:40:45.41161Z","end":"2026-05-09T17:40:45.776831Z","steps":["trace[1057950480] 'read index received'  (duration: 81.147054ms)","trace[1057950480] 'applied index is now lower than readState.Index'  (duration: 284.071734ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:45.77695Z","caller":"traceutil/trace.go:171","msg":"trace[215786768] transaction","detail":"{read_only:false; response_revision:24452; number_of_response:1; }","duration":"409.776197ms","start":"2026-05-09T17:40:45.367123Z","end":"2026-05-09T17:40:45.776899Z","steps":["trace[215786768] 'process raft request'  (duration: 125.690804ms)","trace[215786768] 'compare'  (duration: 283.416086ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:45.776983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.356051ms","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-09T17:40:45.777042Z","caller":"traceutil/trace.go:171","msg":"trace[622374346] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24452; }","duration":"365.434813ms","start":"2026-05-09T17:40:45.411595Z","end":"2026-05-09T17:40:45.777029Z","steps":["trace[622374346] 'agreement among raft nodes before linearized reading'  (duration: 365.32154ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:45.777079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:45.411535Z","time spent":"365.537406ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:40:45.777103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:45.367096Z","time spent":"409.924651ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24436 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T17:40:45.777671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.426199ms","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":"warn","ts":"2026-05-09T17:40:45.777689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.403853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:45.777756Z","caller":"traceutil/trace.go:171","msg":"trace[1449740572] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:24452; }","duration":"138.558953ms","start":"2026-05-09T17:40:45.639177Z","end":"2026-05-09T17:40:45.777736Z","steps":["trace[1449740572] 'agreement among raft nodes before linearized reading'  (duration: 138.411339ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:45.777762Z","caller":"traceutil/trace.go:171","msg":"trace[1396078242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24452; }","duration":"119.482635ms","start":"2026-05-09T17:40:45.658258Z","end":"2026-05-09T17:40:45.777741Z","steps":["trace[1396078242] 'agreement among raft nodes before linearized reading'  (duration: 119.359022ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:46.165411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.064415ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058161 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24438 > 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-09T17:40:46.165533Z","caller":"traceutil/trace.go:171","msg":"trace[1900954908] linearizableReadLoop","detail":"{readStateIndex:25236; appliedIndex:25235; }","duration":"242.504305ms","start":"2026-05-09T17:40:45.923012Z","end":"2026-05-09T17:40:46.165516Z","steps":["trace[1900954908] 'read index received'  (duration: 120.181953ms)","trace[1900954908] 'applied index is now lower than readState.Index'  (duration: 122.321122ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:46.165614Z","caller":"traceutil/trace.go:171","msg":"trace[1241122442] transaction","detail":"{read_only:false; response_revision:24453; number_of_response:1; }","duration":"293.130829ms","start":"2026-05-09T17:40:45.87245Z","end":"2026-05-09T17:40:46.165581Z","steps":["trace[1241122442] 'process raft request'  (duration: 170.798157ms)","trace[1241122442] 'compare'  (duration: 121.846249ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:46.1657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.685409ms","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-09T17:40:46.16573Z","caller":"traceutil/trace.go:171","msg":"trace[1487742235] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24453; }","duration":"242.71664ms","start":"2026-05-09T17:40:45.923005Z","end":"2026-05-09T17:40:46.165721Z","steps":["trace[1487742235] 'agreement among raft nodes before linearized reading'  (duration: 242.585997ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:46.166331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.2929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:46.166374Z","caller":"traceutil/trace.go:171","msg":"trace[1149477341] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:24453; }","duration":"238.365182ms","start":"2026-05-09T17:40:45.927998Z","end":"2026-05-09T17:40:46.166364Z","steps":["trace[1149477341] 'agreement among raft nodes before linearized reading'  (duration: 237.930181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:46.440725Z","caller":"traceutil/trace.go:171","msg":"trace[243124654] transaction","detail":"{read_only:false; response_revision:24454; number_of_response:1; }","duration":"242.129424ms","start":"2026-05-09T17:40:46.19857Z","end":"2026-05-09T17:40:46.4407Z","steps":["trace[243124654] 'process raft request'  (duration: 177.751376ms)","trace[243124654] 'compare'  (duration: 64.273115ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:46.522321Z","caller":"traceutil/trace.go:171","msg":"trace[1164798577] linearizableReadLoop","detail":"{readStateIndex:25240; appliedIndex:25236; }","duration":"181.723604ms","start":"2026-05-09T17:40:46.340578Z","end":"2026-05-09T17:40:46.522301Z","steps":["trace[1164798577] 'read index received'  (duration: 35.75933ms)","trace[1164798577] 'applied index is now lower than readState.Index'  (duration: 145.963414ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:46.522416Z","caller":"traceutil/trace.go:171","msg":"trace[1493605895] transaction","detail":"{read_only:false; response_revision:24455; number_of_response:1; }","duration":"201.407619ms","start":"2026-05-09T17:40:46.320958Z","end":"2026-05-09T17:40:46.522366Z","steps":["trace[1493605895] 'process raft request'  (duration: 201.157531ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:46.522463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.873129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:46.522432Z","caller":"traceutil/trace.go:171","msg":"trace[1858192627] transaction","detail":"{read_only:false; response_revision:24457; number_of_response:1; }","duration":"200.617158ms","start":"2026-05-09T17:40:46.321782Z","end":"2026-05-09T17:40:46.522399Z","steps":["trace[1858192627] 'process raft request'  (duration: 200.491073ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:46.522496Z","caller":"traceutil/trace.go:171","msg":"trace[1880977851] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:24457; }","duration":"181.969161ms","start":"2026-05-09T17:40:46.340518Z","end":"2026-05-09T17:40:46.522487Z","steps":["trace[1880977851] 'agreement among raft nodes before linearized reading'  (duration: 181.886049ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:46.522577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.752294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:46.522622Z","caller":"traceutil/trace.go:171","msg":"trace[1043287843] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:24457; }","duration":"136.852046ms","start":"2026-05-09T17:40:46.38576Z","end":"2026-05-09T17:40:46.522612Z","steps":["trace[1043287843] 'agreement among raft nodes before linearized reading'  (duration: 136.768254ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:46.522794Z","caller":"traceutil/trace.go:171","msg":"trace[1867385285] transaction","detail":"{read_only:false; response_revision:24456; number_of_response:1; }","duration":"201.729368ms","start":"2026-05-09T17:40:46.321049Z","end":"2026-05-09T17:40:46.522779Z","steps":["trace[1867385285] 'process raft request'  (duration: 201.183732ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:46.695454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.828511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418459"}
{"level":"info","ts":"2026-05-09T17:40:46.695531Z","caller":"traceutil/trace.go:171","msg":"trace[1944195123] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:24457; }","duration":"141.943094ms","start":"2026-05-09T17:40:46.553564Z","end":"2026-05-09T17:40:46.695508Z","steps":["trace[1944195123] 'range keys from in-memory index tree'  (duration: 141.602645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:46.816651Z","caller":"traceutil/trace.go:171","msg":"trace[1571670815] transaction","detail":"{read_only:false; response_revision:24458; number_of_response:1; }","duration":"116.590367ms","start":"2026-05-09T17:40:46.700039Z","end":"2026-05-09T17:40:46.816629Z","steps":["trace[1571670815] 'process raft request'  (duration: 116.469043ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:46.861396Z","caller":"traceutil/trace.go:171","msg":"trace[1327533632] transaction","detail":"{read_only:false; response_revision:24459; number_of_response:1; }","duration":"160.91313ms","start":"2026-05-09T17:40:46.700455Z","end":"2026-05-09T17:40:46.861369Z","steps":["trace[1327533632] 'process raft request'  (duration: 159.357058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:47.029011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.042213ms","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-09T17:40:47.029108Z","caller":"traceutil/trace.go:171","msg":"trace[1310624956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24459; }","duration":"108.197907ms","start":"2026-05-09T17:40:46.920893Z","end":"2026-05-09T17:40:47.029091Z","steps":["trace[1310624956] 'range keys from in-memory index tree'  (duration: 107.765886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:47.55944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.42563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"}
{"level":"info","ts":"2026-05-09T17:40:47.559504Z","caller":"traceutil/trace.go:171","msg":"trace[1359059416] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24465; }","duration":"110.544423ms","start":"2026-05-09T17:40:47.448945Z","end":"2026-05-09T17:40:47.55949Z","steps":["trace[1359059416] 'range keys from in-memory index tree'  (duration: 110.246755ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:48.937343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.34595ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058202 > lease_revoke:<id:3e739e0da9754d52>","response":"size:29"}
{"level":"info","ts":"2026-05-09T17:40:48.937453Z","caller":"traceutil/trace.go:171","msg":"trace[1135618944] linearizableReadLoop","detail":"{readStateIndex:25255; appliedIndex:25254; }","duration":"117.12495ms","start":"2026-05-09T17:40:48.820309Z","end":"2026-05-09T17:40:48.937434Z","steps":["trace[1135618944] 'read index received'  (duration: 51.341µs)","trace[1135618944] 'applied index is now lower than readState.Index'  (duration: 117.072019ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:48.937742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.404528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:40:48.937825Z","caller":"traceutil/trace.go:171","msg":"trace[1859718799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24471; }","duration":"117.548452ms","start":"2026-05-09T17:40:48.820257Z","end":"2026-05-09T17:40:48.937805Z","steps":["trace[1859718799] 'agreement among raft nodes before linearized reading'  (duration: 117.316546ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:49.105084Z","caller":"traceutil/trace.go:171","msg":"trace[557215142] transaction","detail":"{read_only:false; response_revision:24472; number_of_response:1; }","duration":"163.486409ms","start":"2026-05-09T17:40:48.941575Z","end":"2026-05-09T17:40:49.105062Z","steps":["trace[557215142] 'process raft request'  (duration: 163.320384ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:49.2366Z","caller":"traceutil/trace.go:171","msg":"trace[1258180923] linearizableReadLoop","detail":"{readStateIndex:25258; appliedIndex:25255; }","duration":"184.743257ms","start":"2026-05-09T17:40:49.051833Z","end":"2026-05-09T17:40:49.236576Z","steps":["trace[1258180923] 'read index received'  (duration: 53.00412ms)","trace[1258180923] 'applied index is now lower than readState.Index'  (duration: 131.738167ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:49.236787Z","caller":"traceutil/trace.go:171","msg":"trace[2078663660] transaction","detail":"{read_only:false; response_revision:24473; number_of_response:1; }","duration":"292.058211ms","start":"2026-05-09T17:40:48.944698Z","end":"2026-05-09T17:40:49.236757Z","steps":["trace[2078663660] 'process raft request'  (duration: 230.944162ms)","trace[2078663660] 'compare'  (duration: 60.736619ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:49.23688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.026686ms","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-09T17:40:49.236958Z","caller":"traceutil/trace.go:171","msg":"trace[851590708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24474; }","duration":"185.136828ms","start":"2026-05-09T17:40:49.051802Z","end":"2026-05-09T17:40:49.236939Z","steps":["trace[851590708] 'agreement among raft nodes before linearized reading'  (duration: 184.936332ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:49.237136Z","caller":"traceutil/trace.go:171","msg":"trace[2115189466] transaction","detail":"{read_only:false; response_revision:24474; number_of_response:1; }","duration":"273.97011ms","start":"2026-05-09T17:40:48.963155Z","end":"2026-05-09T17:40:49.237125Z","steps":["trace[2115189466] 'process raft request'  (duration: 273.373093ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:49.472213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.768037ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058211 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24462 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:49.472555Z","caller":"traceutil/trace.go:171","msg":"trace[266195015] linearizableReadLoop","detail":"{readStateIndex:25260; appliedIndex:25258; }","duration":"226.442449ms","start":"2026-05-09T17:40:49.246088Z","end":"2026-05-09T17:40:49.472531Z","steps":["trace[266195015] 'read index received'  (duration: 57.867641ms)","trace[266195015] 'applied index is now lower than readState.Index'  (duration: 168.572568ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:49.472661Z","caller":"traceutil/trace.go:171","msg":"trace[12906671] transaction","detail":"{read_only:false; response_revision:24476; number_of_response:1; }","duration":"231.617689ms","start":"2026-05-09T17:40:49.241033Z","end":"2026-05-09T17:40:49.472651Z","steps":["trace[12906671] 'process raft request'  (duration: 120.351528ms)","trace[12906671] 'compare'  (duration: 110.471019ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:49.472855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.202463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-09T17:40:49.472872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.758848ms","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-09T17:40:49.472933Z","caller":"traceutil/trace.go:171","msg":"trace[689004451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24477; }","duration":"226.299715ms","start":"2026-05-09T17:40:49.246616Z","end":"2026-05-09T17:40:49.472915Z","steps":["trace[689004451] 'agreement among raft nodes before linearized reading'  (duration: 226.09227ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:49.472963Z","caller":"traceutil/trace.go:171","msg":"trace[1078814270] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24477; }","duration":"226.873331ms","start":"2026-05-09T17:40:49.246071Z","end":"2026-05-09T17:40:49.472944Z","steps":["trace[1078814270] 'agreement among raft nodes before linearized reading'  (duration: 226.657875ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:49.677374Z","caller":"traceutil/trace.go:171","msg":"trace[1899866304] transaction","detail":"{read_only:false; response_revision:24479; number_of_response:1; }","duration":"200.472094ms","start":"2026-05-09T17:40:49.476877Z","end":"2026-05-09T17:40:49.677349Z","steps":["trace[1899866304] 'process raft request'  (duration: 115.405594ms)","trace[1899866304] 'compare'  (duration: 84.896985ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:49.770321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.763482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:49.770397Z","caller":"traceutil/trace.go:171","msg":"trace[1224450658] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24480; }","duration":"126.879785ms","start":"2026-05-09T17:40:49.643498Z","end":"2026-05-09T17:40:49.770378Z","steps":["trace[1224450658] 'agreement among raft nodes before linearized reading'  (duration: 126.721221ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:49.770635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.64946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:49.770735Z","caller":"traceutil/trace.go:171","msg":"trace[1557748059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24480; }","duration":"115.848976ms","start":"2026-05-09T17:40:49.654862Z","end":"2026-05-09T17:40:49.770711Z","steps":["trace[1557748059] 'agreement among raft nodes before linearized reading'  (duration: 115.64277ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:50.515592Z","caller":"traceutil/trace.go:171","msg":"trace[1948716277] linearizableReadLoop","detail":"{readStateIndex:25267; appliedIndex:25266; }","duration":"114.8674ms","start":"2026-05-09T17:40:50.400701Z","end":"2026-05-09T17:40:50.515569Z","steps":["trace[1948716277] 'read index received'  (duration: 114.724046ms)","trace[1948716277] 'applied index is now lower than readState.Index'  (duration: 142.204µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:50.515642Z","caller":"traceutil/trace.go:171","msg":"trace[1343825643] transaction","detail":"{read_only:false; response_revision:24483; number_of_response:1; }","duration":"245.830096ms","start":"2026-05-09T17:40:50.269778Z","end":"2026-05-09T17:40:50.515608Z","steps":["trace[1343825643] 'process raft request'  (duration: 245.650511ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:50.515775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.053945ms","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-09T17:40:50.515852Z","caller":"traceutil/trace.go:171","msg":"trace[323188890] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24483; }","duration":"115.172558ms","start":"2026-05-09T17:40:50.400662Z","end":"2026-05-09T17:40:50.515834Z","steps":["trace[323188890] 'agreement among raft nodes before linearized reading'  (duration: 115.035014ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:50.75792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.028334ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058236 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24470 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:50.758175Z","caller":"traceutil/trace.go:171","msg":"trace[2012443452] transaction","detail":"{read_only:false; response_revision:24485; number_of_response:1; }","duration":"143.104797ms","start":"2026-05-09T17:40:50.615036Z","end":"2026-05-09T17:40:50.758141Z","steps":["trace[2012443452] 'process raft request'  (duration: 13.776194ms)","trace[2012443452] 'compare'  (duration: 128.738647ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:50.758209Z","caller":"traceutil/trace.go:171","msg":"trace[1884702883] transaction","detail":"{read_only:false; response_revision:24486; number_of_response:1; }","duration":"142.531891ms","start":"2026-05-09T17:40:50.61566Z","end":"2026-05-09T17:40:50.758192Z","steps":["trace[1884702883] 'process raft request'  (duration: 142.358066ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:50.75835Z","caller":"traceutil/trace.go:171","msg":"trace[868543718] linearizableReadLoop","detail":"{readStateIndex:25271; appliedIndex:25268; }","duration":"114.635993ms","start":"2026-05-09T17:40:50.643688Z","end":"2026-05-09T17:40:50.758324Z","steps":["trace[868543718] 'read index received'  (duration: 108.022613ms)","trace[868543718] 'applied index is now lower than readState.Index'  (duration: 6.61015ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:50.758441Z","caller":"traceutil/trace.go:171","msg":"trace[1841568495] transaction","detail":"{read_only:false; response_revision:24487; number_of_response:1; }","duration":"142.099529ms","start":"2026-05-09T17:40:50.616331Z","end":"2026-05-09T17:40:50.758431Z","steps":["trace[1841568495] 'process raft request'  (duration: 141.823172ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:50.7585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.791087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:40:50.758518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.593809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:50.758551Z","caller":"traceutil/trace.go:171","msg":"trace[485701155] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:24487; }","duration":"114.88467ms","start":"2026-05-09T17:40:50.64364Z","end":"2026-05-09T17:40:50.758525Z","steps":["trace[485701155] 'agreement among raft nodes before linearized reading'  (duration: 114.803627ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:50.758565Z","caller":"traceutil/trace.go:171","msg":"trace[372367499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24487; }","duration":"101.664431ms","start":"2026-05-09T17:40:50.656889Z","end":"2026-05-09T17:40:50.758553Z","steps":["trace[372367499] 'agreement among raft nodes before linearized reading'  (duration: 101.589069ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:51.031937Z","caller":"traceutil/trace.go:171","msg":"trace[1675735399] transaction","detail":"{read_only:false; response_revision:24488; number_of_response:1; }","duration":"268.785219ms","start":"2026-05-09T17:40:50.763114Z","end":"2026-05-09T17:40:51.0319Z","steps":["trace[1675735399] 'process raft request'  (duration: 268.500321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:51.552146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.587556ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188058248 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24473 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:51.552367Z","caller":"traceutil/trace.go:171","msg":"trace[1966915027] transaction","detail":"{read_only:false; response_revision:24491; number_of_response:1; }","duration":"232.36388ms","start":"2026-05-09T17:40:51.319985Z","end":"2026-05-09T17:40:51.552349Z","steps":["trace[1966915027] 'process raft request'  (duration: 101.497616ms)","trace[1966915027] 'compare'  (duration: 130.395741ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:51.760447Z","caller":"traceutil/trace.go:171","msg":"trace[201863382] linearizableReadLoop","detail":"{readStateIndex:25278; appliedIndex:25277; }","duration":"101.620699ms","start":"2026-05-09T17:40:51.658801Z","end":"2026-05-09T17:40:51.760422Z","steps":["trace[201863382] 'read index received'  (duration: 87.037873ms)","trace[201863382] 'applied index is now lower than readState.Index'  (duration: 14.581916ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:51.760577Z","caller":"traceutil/trace.go:171","msg":"trace[347150233] transaction","detail":"{read_only:false; response_revision:24494; number_of_response:1; }","duration":"140.127605ms","start":"2026-05-09T17:40:51.62041Z","end":"2026-05-09T17:40:51.760538Z","steps":["trace[347150233] 'process raft request'  (duration: 125.385265ms)","trace[347150233] 'compare'  (duration: 14.529404ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:51.760623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.791703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:51.760684Z","caller":"traceutil/trace.go:171","msg":"trace[741769355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24494; }","duration":"101.896767ms","start":"2026-05-09T17:40:51.658773Z","end":"2026-05-09T17:40:51.76067Z","steps":["trace[741769355] 'agreement among raft nodes before linearized reading'  (duration: 101.786464ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:51.900132Z","caller":"traceutil/trace.go:171","msg":"trace[1375088864] transaction","detail":"{read_only:false; response_revision:24495; number_of_response:1; }","duration":"134.856352ms","start":"2026-05-09T17:40:51.765249Z","end":"2026-05-09T17:40:51.900106Z","steps":["trace[1375088864] 'process raft request'  (duration: 126.622208ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.118244Z","caller":"traceutil/trace.go:171","msg":"trace[1415463714] linearizableReadLoop","detail":"{readStateIndex:25973; appliedIndex:25972; }","duration":"155.190742ms","start":"2026-05-09T17:41:59.963028Z","end":"2026-05-09T17:42:00.118218Z","steps":["trace[1415463714] 'read index received'  (duration: 73.062017ms)","trace[1415463714] 'applied index is now lower than readState.Index'  (duration: 82.127675ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:42:00.118432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.383457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:42:00.118469Z","caller":"traceutil/trace.go:171","msg":"trace[128013053] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:25173; }","duration":"155.461549ms","start":"2026-05-09T17:41:59.962994Z","end":"2026-05-09T17:42:00.118455Z","steps":["trace[128013053] 'agreement among raft nodes before linearized reading'  (duration: 155.382297ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.118429Z","caller":"traceutil/trace.go:171","msg":"trace[961117309] transaction","detail":"{read_only:false; response_revision:25173; number_of_response:1; }","duration":"173.238152ms","start":"2026-05-09T17:41:59.94513Z","end":"2026-05-09T17:42:00.118368Z","steps":["trace[961117309] 'process raft request'  (duration: 90.953343ms)","trace[961117309] 'compare'  (duration: 81.995381ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:42:00.157601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.504521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:42:00.157676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.417439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:42:00.157894Z","caller":"traceutil/trace.go:171","msg":"trace[665560228] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:25174; }","duration":"194.640415ms","start":"2026-05-09T17:41:59.963234Z","end":"2026-05-09T17:42:00.157874Z","steps":["trace[665560228] 'agreement among raft nodes before linearized reading'  (duration: 194.377488ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.157687Z","caller":"traceutil/trace.go:171","msg":"trace[1793610697] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:25174; }","duration":"194.624474ms","start":"2026-05-09T17:41:59.963043Z","end":"2026-05-09T17:42:00.157668Z","steps":["trace[1793610697] 'agreement among raft nodes before linearized reading'  (duration: 194.438809ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:00.157689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.985617ms","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-09T17:42:00.158092Z","caller":"traceutil/trace.go:171","msg":"trace[759059432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25174; }","duration":"144.411079ms","start":"2026-05-09T17:42:00.013655Z","end":"2026-05-09T17:42:00.158066Z","steps":["trace[759059432] 'agreement among raft nodes before linearized reading'  (duration: 143.890325ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:00.157741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.60604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5082"}
{"level":"info","ts":"2026-05-09T17:42:00.158189Z","caller":"traceutil/trace.go:171","msg":"trace[1274306258] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:25174; }","duration":"189.095363ms","start":"2026-05-09T17:41:59.969066Z","end":"2026-05-09T17:42:00.158161Z","steps":["trace[1274306258] 'agreement among raft nodes before linearized reading'  (duration: 188.508128ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:00.404419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.875909ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4500114234188060110 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25162 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:42:00.404697Z","caller":"traceutil/trace.go:171","msg":"trace[1715283090] linearizableReadLoop","detail":"{readStateIndex:25977; appliedIndex:25975; }","duration":"111.009909ms","start":"2026-05-09T17:42:00.29367Z","end":"2026-05-09T17:42:00.40468Z","steps":["trace[1715283090] 'read index received'  (duration: 69.903181ms)","trace[1715283090] 'applied index is now lower than readState.Index'  (duration: 41.105708ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:42:00.40477Z","caller":"traceutil/trace.go:171","msg":"trace[1654104926] transaction","detail":"{read_only:false; response_revision:25176; number_of_response:1; }","duration":"197.136342ms","start":"2026-05-09T17:42:00.207606Z","end":"2026-05-09T17:42:00.404742Z","steps":["trace[1654104926] 'process raft request'  (duration: 72.847812ms)","trace[1654104926] 'compare'  (duration: 123.481079ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:42:00.404825Z","caller":"traceutil/trace.go:171","msg":"trace[966841017] transaction","detail":"{read_only:false; response_revision:25177; number_of_response:1; }","duration":"191.032256ms","start":"2026-05-09T17:42:00.213733Z","end":"2026-05-09T17:42:00.404765Z","steps":["trace[966841017] 'process raft request'  (duration: 190.871921ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:00.405081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.38837ms","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-09T17:42:00.405198Z","caller":"traceutil/trace.go:171","msg":"trace[1876049510] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25177; }","duration":"111.559944ms","start":"2026-05-09T17:42:00.293595Z","end":"2026-05-09T17:42:00.405155Z","steps":["trace[1876049510] 'agreement among raft nodes before linearized reading'  (duration: 111.206975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:43:24.30037Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006889.wal"}
{"level":"info","ts":"2026-05-09T17:44:30.485742Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23717}
{"level":"info","ts":"2026-05-09T17:44:30.616927Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23717,"took":"125.112893ms","hash":4100181878,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":38105088,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-05-09T17:44:30.61698Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4100181878,"revision":23717,"compact-revision":20390}
{"level":"info","ts":"2026-05-09T17:44:47.889244Z","caller":"traceutil/trace.go:171","msg":"trace[1045474634] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"120.922749ms","start":"2026-05-09T17:44:47.768293Z","end":"2026-05-09T17:44:47.889215Z","steps":["trace[1045474634] 'process raft request'  (duration: 109.381245ms)","trace[1045474634] 'compare'  (duration: 11.341918ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:44:47.889413Z","caller":"traceutil/trace.go:171","msg":"trace[2069905177] transaction","detail":"{read_only:false; response_revision:26849; number_of_response:1; }","duration":"119.622013ms","start":"2026-05-09T17:44:47.769748Z","end":"2026-05-09T17:44:47.88937Z","steps":["trace[2069905177] 'process raft request'  (duration: 119.386046ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:49:30.490885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26700}
{"level":"info","ts":"2026-05-09T17:49:30.631528Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26700,"took":"136.493373ms","hash":3793482125,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":31461376,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T17:49:30.631603Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3793482125,"revision":26700,"compact-revision":23717}
{"level":"info","ts":"2026-05-09T17:49:48.520692Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T17:49:48.526702Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-09T17:49:48.526889Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-09T17:54:30.496545Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28965}
{"level":"info","ts":"2026-05-09T17:54:30.633373Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28965,"took":"133.47776ms","hash":3692143576,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":30777344,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T17:54:30.633469Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3692143576,"revision":28965,"compact-revision":26700}
{"level":"info","ts":"2026-05-09T17:59:30.504941Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31192}
{"level":"info","ts":"2026-05-09T17:59:30.650216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31192,"took":"141.532921ms","hash":3078506708,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":32206848,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T17:59:30.650323Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3078506708,"revision":31192,"compact-revision":28965}
{"level":"info","ts":"2026-05-09T18:04:30.511391Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33519}
{"level":"info","ts":"2026-05-09T18:04:30.663975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33519,"took":"146.917379ms","hash":4093148767,"current-db-size-bytes":60387328,"current-db-size":"60 MB","current-db-size-in-use-bytes":32890880,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-09T18:04:30.664036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4093148767,"revision":33519,"compact-revision":31192}
{"level":"info","ts":"2026-05-09T18:09:30.516Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35815}
{"level":"info","ts":"2026-05-09T18:09:30.654083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35815,"took":"133.773869ms","hash":2484304247,"current-db-size-bytes":60387328,"current-db-size":"60 MB","current-db-size-in-use-bytes":30826496,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T18:09:30.654151Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2484304247,"revision":35815,"compact-revision":33519}