{"level":"warn","ts":"2026-09-12T06:35:12.225843Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-12T06:35:12.226036Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.58: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://162.253.55.58:2380","--initial-cluster=instance=https://162.253.55.58:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.58:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.58: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-09-12T06:35:12.226167Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-12T06:35:12.226198Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.58:2380"]}
{"level":"info","ts":"2026-09-12T06:35:12.226238Z","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-09-12T06:35:12.227427Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.58:2379"]}
{"level":"info","ts":"2026-09-12T06:35:12.227598Z","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://162.253.55.58:2380"],"listen-peer-urls":["https://162.253.55.58:2380"],"advertise-client-urls":["https://162.253.55.58:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.58:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.58: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-09-12T06:35:12.232674Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.67496ms"}
{"level":"info","ts":"2026-09-12T06:35:12.239937Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51815f4ecef28267","cluster-id":"f8cbfcd78223a537"}
{"level":"info","ts":"2026-09-12T06:35:12.240086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-12T06:35:12.240154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 became follower at term 0"}
{"level":"info","ts":"2026-09-12T06:35:12.24018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51815f4ecef28267 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-12T06:35:12.240201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 became follower at term 1"}
{"level":"info","ts":"2026-09-12T06:35:12.240402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 switched to configuration voters=(5873080181151924839)"}
{"level":"warn","ts":"2026-09-12T06:35:12.247854Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-12T06:35:12.25004Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-12T06:35:12.251808Z","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-09-12T06:35:12.254937Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51815f4ecef28267","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-12T06:35:12.255655Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51815f4ecef28267","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-12T06:35:12.255866Z","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-09-12T06:35:12.255954Z","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-09-12T06:35:12.255964Z","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-09-12T06:35:12.256597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 switched to configuration voters=(5873080181151924839)"}
{"level":"info","ts":"2026-09-12T06:35:12.257918Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f8cbfcd78223a537","local-member-id":"51815f4ecef28267","added-peer-id":"51815f4ecef28267","added-peer-peer-urls":["https://162.253.55.58:2380"]}
{"level":"info","ts":"2026-09-12T06:35:12.261482Z","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-09-12T06:35:12.261642Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.58:2380"}
{"level":"info","ts":"2026-09-12T06:35:12.261812Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.58:2380"}
{"level":"info","ts":"2026-09-12T06:35:12.261936Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51815f4ecef28267","initial-advertise-peer-urls":["https://162.253.55.58:2380"],"listen-peer-urls":["https://162.253.55.58:2380"],"advertise-client-urls":["https://162.253.55.58:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.58:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-12T06:35:12.262007Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-12T06:35:12.441836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-12T06:35:12.441987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-12T06:35:12.442047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 received MsgPreVoteResp from 51815f4ecef28267 at term 1"}
{"level":"info","ts":"2026-09-12T06:35:12.442086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 became candidate at term 2"}
{"level":"info","ts":"2026-09-12T06:35:12.442108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 received MsgVoteResp from 51815f4ecef28267 at term 2"}
{"level":"info","ts":"2026-09-12T06:35:12.442129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51815f4ecef28267 became leader at term 2"}
{"level":"info","ts":"2026-09-12T06:35:12.442169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51815f4ecef28267 elected leader 51815f4ecef28267 at term 2"}
{"level":"info","ts":"2026-09-12T06:35:12.444302Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51815f4ecef28267","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.58:2379]}","request-path":"/0/members/51815f4ecef28267/attributes","cluster-id":"f8cbfcd78223a537","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-12T06:35:12.444736Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-12T06:35:12.444825Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T06:35:12.444877Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-12T06:35:12.445168Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-12T06:35:12.44521Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-12T06:35:12.446095Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f8cbfcd78223a537","local-member-id":"51815f4ecef28267","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T06:35:12.446244Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T06:35:12.447628Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.58:2379"}
{"level":"info","ts":"2026-09-12T06:35:12.448025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-12T06:35:12.447839Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-09-12T06:36:07.425037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.959085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-09-12T06:36:07.42516Z","caller":"traceutil/trace.go:171","msg":"trace[885798295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"208.1953ms","start":"2026-09-12T06:36:07.216943Z","end":"2026-09-12T06:36:07.425139Z","steps":["trace[885798295] 'range keys from in-memory index tree'  (duration: 207.756501ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:36:07.510953Z","caller":"traceutil/trace.go:171","msg":"trace[1328263254] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"190.115316ms","start":"2026-09-12T06:36:07.320797Z","end":"2026-09-12T06:36:07.510912Z","steps":["trace[1328263254] 'process raft request'  (duration: 189.238348ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:36:07.988147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.851186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q6h29\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-09-12T06:36:07.98833Z","caller":"traceutil/trace.go:171","msg":"trace[356030272] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q6h29; range_end:; response_count:1; response_revision:659; }","duration":"437.104332ms","start":"2026-09-12T06:36:07.551196Z","end":"2026-09-12T06:36:07.9883Z","steps":["trace[356030272] 'range keys from in-memory index tree'  (duration: 436.603621ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:36:07.988387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:36:07.551172Z","time spent":"437.201165ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-q6h29\" "}
{"level":"info","ts":"2026-09-12T06:36:08.014121Z","caller":"traceutil/trace.go:171","msg":"trace[1099890572] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"163.682934ms","start":"2026-09-12T06:36:07.850407Z","end":"2026-09-12T06:36:08.01409Z","steps":["trace[1099890572] 'read index received'  (duration: 163.409399ms)","trace[1099890572] 'applied index is now lower than readState.Index'  (duration: 272.225µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:36:08.014242Z","caller":"traceutil/trace.go:171","msg":"trace[1156852052] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"424.897072ms","start":"2026-09-12T06:36:07.589289Z","end":"2026-09-12T06:36:08.014186Z","steps":["trace[1156852052] 'process raft request'  (duration: 424.535545ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:36:08.014525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.102533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-12T06:36:08.014582Z","caller":"traceutil/trace.go:171","msg":"trace[236676505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"164.209785ms","start":"2026-09-12T06:36:07.850356Z","end":"2026-09-12T06:36:08.014566Z","steps":["trace[236676505] 'agreement among raft nodes before linearized reading'  (duration: 163.874728ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:36:08.014831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:36:07.589253Z","time spent":"425.114356ms","remote":"127.0.0.1:60056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-09-12T06:36:25.12355Z","caller":"traceutil/trace.go:171","msg":"trace[307281683] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"162.936234ms","start":"2026-09-12T06:36:24.96058Z","end":"2026-09-12T06:36:25.123517Z","steps":["trace[307281683] 'process raft request'  (duration: 162.713309ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:36:53.950856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.716503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-12T06:36:53.951022Z","caller":"traceutil/trace.go:171","msg":"trace[1587283298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1228; }","duration":"174.991729ms","start":"2026-09-12T06:36:53.775998Z","end":"2026-09-12T06:36:53.950989Z","steps":["trace[1587283298] 'range keys from in-memory index tree'  (duration: 174.394447ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:37:44.509509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.013676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a061fecb-6a10-4736-adad-98d99c32f471\" ","response":"range_response_count:1 size:3746"}
{"level":"info","ts":"2026-09-12T06:37:44.509618Z","caller":"traceutil/trace.go:171","msg":"trace[1704879318] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a061fecb-6a10-4736-adad-98d99c32f471; range_end:; response_count:1; response_revision:1921; }","duration":"331.19753ms","start":"2026-09-12T06:37:44.17839Z","end":"2026-09-12T06:37:44.509588Z","steps":["trace[1704879318] 'range keys from in-memory index tree'  (duration: 330.883693ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:37:44.509687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:37:44.178371Z","time spent":"331.297872ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a061fecb-6a10-4736-adad-98d99c32f471\" "}
{"level":"warn","ts":"2026-09-12T06:37:44.510021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.897241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-09-12T06:37:44.510089Z","caller":"traceutil/trace.go:171","msg":"trace[2097551718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1921; }","duration":"238.997003ms","start":"2026-09-12T06:37:44.271074Z","end":"2026-09-12T06:37:44.510071Z","steps":["trace[2097551718] 'range keys from in-memory index tree'  (duration: 238.676976ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:37:44.667254Z","caller":"traceutil/trace.go:171","msg":"trace[2009714070] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"149.619366ms","start":"2026-09-12T06:37:44.517594Z","end":"2026-09-12T06:37:44.667214Z","steps":["trace[2009714070] 'process raft request'  (duration: 149.298059ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:37:44.923191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.19843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-12T06:37:44.923293Z","caller":"traceutil/trace.go:171","msg":"trace[2025047935] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1923; }","duration":"177.353564ms","start":"2026-09-12T06:37:44.745913Z","end":"2026-09-12T06:37:44.923267Z","steps":["trace[2025047935] 'range keys from in-memory index tree'  (duration: 176.929165ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:38:34.066146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.672643ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452656688 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2228 > 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:16"}
{"level":"info","ts":"2026-09-12T06:38:34.066298Z","caller":"traceutil/trace.go:171","msg":"trace[1874205130] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2326; }","duration":"181.246205ms","start":"2026-09-12T06:38:33.88503Z","end":"2026-09-12T06:38:34.066276Z","steps":["trace[1874205130] 'read index received'  (duration: 74.904347ms)","trace[1874205130] 'applied index is now lower than readState.Index'  (duration: 106.340478ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:38:34.066365Z","caller":"traceutil/trace.go:171","msg":"trace[28902770] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"210.544339ms","start":"2026-09-12T06:38:33.855793Z","end":"2026-09-12T06:38:34.066337Z","steps":["trace[28902770] 'process raft request'  (duration: 104.219142ms)","trace[28902770] 'compare'  (duration: 105.433847ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T06:38:34.066598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.706877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T06:38:34.066624Z","caller":"traceutil/trace.go:171","msg":"trace[949207332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2240; }","duration":"130.797699ms","start":"2026-09-12T06:38:33.93582Z","end":"2026-09-12T06:38:34.066618Z","steps":["trace[949207332] 'agreement among raft nodes before linearized reading'  (duration: 130.722387ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:38:34.066611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.983381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T06:38:34.066696Z","caller":"traceutil/trace.go:171","msg":"trace[1683638594] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2240; }","duration":"145.111104ms","start":"2026-09-12T06:38:33.921568Z","end":"2026-09-12T06:38:34.066679Z","steps":["trace[1683638594] 'agreement among raft nodes before linearized reading'  (duration: 144.961531ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:38:34.066747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.717304ms","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-09-12T06:38:34.067265Z","caller":"traceutil/trace.go:171","msg":"trace[1244696743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2240; }","duration":"181.887408ms","start":"2026-09-12T06:38:33.884965Z","end":"2026-09-12T06:38:34.066853Z","steps":["trace[1244696743] 'agreement among raft nodes before linearized reading'  (duration: 181.428088ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:43:21.253182Z","caller":"traceutil/trace.go:171","msg":"trace[414594293] linearizableReadLoop","detail":"{readStateIndex:4315; appliedIndex:4314; }","duration":"133.830835ms","start":"2026-09-12T06:43:21.119325Z","end":"2026-09-12T06:43:21.253156Z","steps":["trace[414594293] 'read index received'  (duration: 133.661531ms)","trace[414594293] 'applied index is now lower than readState.Index'  (duration: 168.064µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:43:21.253289Z","caller":"traceutil/trace.go:171","msg":"trace[412391289] transaction","detail":"{read_only:false; response_revision:4157; number_of_response:1; }","duration":"135.868099ms","start":"2026-09-12T06:43:21.117388Z","end":"2026-09-12T06:43:21.253256Z","steps":["trace[412391289] 'process raft request'  (duration: 135.581963ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:43:21.253538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.172962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T06:43:21.253576Z","caller":"traceutil/trace.go:171","msg":"trace[611620988] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4157; }","duration":"134.254804ms","start":"2026-09-12T06:43:21.119308Z","end":"2026-09-12T06:43:21.253563Z","steps":["trace[611620988] 'agreement among raft nodes before linearized reading'  (duration: 134.011839ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:45:13.023299Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2970}
{"level":"warn","ts":"2026-09-12T06:45:13.16193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.135843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T06:45:13.162042Z","caller":"traceutil/trace.go:171","msg":"trace[1242350143] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5649; }","duration":"135.282136ms","start":"2026-09-12T06:45:13.026736Z","end":"2026-09-12T06:45:13.162018Z","steps":["trace[1242350143] 'count revisions from in-memory index tree'  (duration: 134.897019ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:45:13.405052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.445437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452664813 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5599 > 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:16"}
{"level":"info","ts":"2026-09-12T06:45:13.405294Z","caller":"traceutil/trace.go:171","msg":"trace[1838797811] transaction","detail":"{read_only:false; response_revision:5650; number_of_response:1; }","duration":"362.533797ms","start":"2026-09-12T06:45:13.042695Z","end":"2026-09-12T06:45:13.405229Z","steps":["trace[1838797811] 'process raft request'  (duration: 28.770194ms)","trace[1838797811] 'compare'  (duration: 90.714066ms)","trace[1838797811] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:531; } (duration: 242.503186ms)"],"step_count":3}
{"level":"warn","ts":"2026-09-12T06:45:13.405575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:45:13.042653Z","time spent":"362.802042ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5599 > 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-09-12T06:45:13.457637Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2970,"took":"430.958938ms","hash":14934124,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":31363072,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-12T06:45:13.457724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":14934124,"revision":2970,"compact-revision":-1}
{"level":"info","ts":"2026-09-12T06:45:26.76195Z","caller":"traceutil/trace.go:171","msg":"trace[1561829366] transaction","detail":"{read_only:false; response_revision:5905; number_of_response:1; }","duration":"106.30533ms","start":"2026-09-12T06:45:26.655612Z","end":"2026-09-12T06:45:26.761917Z","steps":["trace[1561829366] 'process raft request'  (duration: 106.111506ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:45:26.884635Z","caller":"traceutil/trace.go:171","msg":"trace[2112966451] linearizableReadLoop","detail":"{readStateIndex:6127; appliedIndex:6126; }","duration":"119.245305ms","start":"2026-09-12T06:45:26.765346Z","end":"2026-09-12T06:45:26.884592Z","steps":["trace[2112966451] 'read index received'  (duration: 99.278199ms)","trace[2112966451] 'applied index is now lower than readState.Index'  (duration: 19.964886ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:45:26.884686Z","caller":"traceutil/trace.go:171","msg":"trace[692244987] transaction","detail":"{read_only:false; response_revision:5906; number_of_response:1; }","duration":"224.993792ms","start":"2026-09-12T06:45:26.659661Z","end":"2026-09-12T06:45:26.884655Z","steps":["trace[692244987] 'process raft request'  (duration: 204.948875ms)","trace[692244987] 'compare'  (duration: 19.478735ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T06:45:26.884999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.624664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s2lp4\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-09-12T06:45:26.885059Z","caller":"traceutil/trace.go:171","msg":"trace[1934459296] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s2lp4; range_end:; response_count:1; response_revision:5906; }","duration":"119.716515ms","start":"2026-09-12T06:45:26.765328Z","end":"2026-09-12T06:45:26.885044Z","steps":["trace[1934459296] 'agreement among raft nodes before linearized reading'  (duration: 119.413089ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:50:13.031948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5648}
{"level":"info","ts":"2026-09-12T06:50:13.118409Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5648,"took":"84.765831ms","hash":1871132007,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":27979776,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-12T06:50:13.118503Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1871132007,"revision":5648,"compact-revision":2970}
{"level":"info","ts":"2026-09-12T06:52:01.875747Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ab.wal"}
{"level":"info","ts":"2026-09-12T06:52:05.659947Z","caller":"traceutil/trace.go:171","msg":"trace[1363817136] transaction","detail":"{read_only:false; response_revision:8837; number_of_response:1; }","duration":"123.794383ms","start":"2026-09-12T06:52:05.536104Z","end":"2026-09-12T06:52:05.659899Z","steps":["trace[1363817136] 'process raft request'  (duration: 123.491526ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:05.835002Z","caller":"traceutil/trace.go:171","msg":"trace[799139552] transaction","detail":"{read_only:false; response_revision:8838; number_of_response:1; }","duration":"117.196643ms","start":"2026-09-12T06:52:05.717772Z","end":"2026-09-12T06:52:05.834968Z","steps":["trace[799139552] 'process raft request'  (duration: 46.91951ms)","trace[799139552] 'compare'  (duration: 69.910215ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:52:17.325573Z","caller":"traceutil/trace.go:171","msg":"trace[1062349376] transaction","detail":"{read_only:false; response_revision:8895; number_of_response:1; }","duration":"107.226262ms","start":"2026-09-12T06:52:17.218279Z","end":"2026-09-12T06:52:17.325505Z","steps":["trace[1062349376] 'process raft request'  (duration: 106.979697ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:17.475137Z","caller":"traceutil/trace.go:171","msg":"trace[1587404742] transaction","detail":"{read_only:false; response_revision:8897; number_of_response:1; }","duration":"251.249482ms","start":"2026-09-12T06:52:17.223861Z","end":"2026-09-12T06:52:17.47511Z","steps":["trace[1587404742] 'process raft request'  (duration: 251.17548ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:17.475185Z","caller":"traceutil/trace.go:171","msg":"trace[1095551048] transaction","detail":"{read_only:false; response_revision:8896; number_of_response:1; }","duration":"252.884407ms","start":"2026-09-12T06:52:17.222269Z","end":"2026-09-12T06:52:17.475154Z","steps":["trace[1095551048] 'process raft request'  (duration: 252.606041ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:17.475346Z","caller":"traceutil/trace.go:171","msg":"trace[299601723] transaction","detail":"{read_only:false; response_revision:8898; number_of_response:1; }","duration":"208.057452ms","start":"2026-09-12T06:52:17.267277Z","end":"2026-09-12T06:52:17.475334Z","steps":["trace[299601723] 'process raft request'  (duration: 207.795616ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:17.475366Z","caller":"traceutil/trace.go:171","msg":"trace[74876412] linearizableReadLoop","detail":"{readStateIndex:9215; appliedIndex:9212; }","duration":"238.77369ms","start":"2026-09-12T06:52:17.236554Z","end":"2026-09-12T06:52:17.475328Z","steps":["trace[74876412] 'read index received'  (duration: 88.819565ms)","trace[74876412] 'applied index is now lower than readState.Index'  (duration: 149.950794ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T06:52:17.475494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.941733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T06:52:17.475554Z","caller":"traceutil/trace.go:171","msg":"trace[80168478] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:8898; }","duration":"239.038795ms","start":"2026-09-12T06:52:17.236488Z","end":"2026-09-12T06:52:17.475527Z","steps":["trace[80168478] 'agreement among raft nodes before linearized reading'  (duration: 238.933002ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:52:17.475686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.046318ms","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-09-12T06:52:17.475719Z","caller":"traceutil/trace.go:171","msg":"trace[701344617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8898; }","duration":"143.186192ms","start":"2026-09-12T06:52:17.332525Z","end":"2026-09-12T06:52:17.475711Z","steps":["trace[701344617] 'agreement among raft nodes before linearized reading'  (duration: 142.976457ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:18.277565Z","caller":"traceutil/trace.go:171","msg":"trace[1580294895] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"193.289729ms","start":"2026-09-12T06:52:18.08423Z","end":"2026-09-12T06:52:18.27752Z","steps":["trace[1580294895] 'process raft request'  (duration: 118.344867ms)","trace[1580294895] 'compare'  (duration: 74.645116ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:52:18.277567Z","caller":"traceutil/trace.go:171","msg":"trace[1181980151] linearizableReadLoop","detail":"{readStateIndex:9221; appliedIndex:9220; }","duration":"137.41374ms","start":"2026-09-12T06:52:18.140102Z","end":"2026-09-12T06:52:18.277516Z","steps":["trace[1181980151] 'read index received'  (duration: 62.366616ms)","trace[1181980151] 'applied index is now lower than readState.Index'  (duration: 75.046084ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T06:52:18.27758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.65357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-09-12T06:52:18.277693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.594564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-12T06:52:18.277713Z","caller":"traceutil/trace.go:171","msg":"trace[1880745271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8902; }","duration":"223.871385ms","start":"2026-09-12T06:52:18.053833Z","end":"2026-09-12T06:52:18.277704Z","steps":["trace[1880745271] 'range keys from in-memory index tree'  (duration: 223.457226ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:18.277745Z","caller":"traceutil/trace.go:171","msg":"trace[1092381419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8903; }","duration":"137.662715ms","start":"2026-09-12T06:52:18.140052Z","end":"2026-09-12T06:52:18.277715Z","steps":["trace[1092381419] 'agreement among raft nodes before linearized reading'  (duration: 137.561243ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:47.874224Z","caller":"traceutil/trace.go:171","msg":"trace[53550528] transaction","detail":"{read_only:false; response_revision:9112; number_of_response:1; }","duration":"382.943143ms","start":"2026-09-12T06:52:47.49125Z","end":"2026-09-12T06:52:47.874193Z","steps":["trace[53550528] 'process raft request'  (duration: 382.745329ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:52:47.874472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:52:47.491225Z","time spent":"383.143516ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9101 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-12T06:52:47.878775Z","caller":"traceutil/trace.go:171","msg":"trace[1309329080] linearizableReadLoop","detail":"{readStateIndex:9440; appliedIndex:9438; }","duration":"245.195575ms","start":"2026-09-12T06:52:47.633556Z","end":"2026-09-12T06:52:47.878751Z","steps":["trace[1309329080] 'read index received'  (duration: 240.502306ms)","trace[1309329080] 'applied index is now lower than readState.Index'  (duration: 4.691999ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:52:47.879165Z","caller":"traceutil/trace.go:171","msg":"trace[378228349] transaction","detail":"{read_only:false; response_revision:9113; number_of_response:1; }","duration":"282.829609ms","start":"2026-09-12T06:52:47.596315Z","end":"2026-09-12T06:52:47.879144Z","steps":["trace[378228349] 'process raft request'  (duration: 282.172286ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:52:47.879627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.081924ms","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-09-12T06:52:47.879682Z","caller":"traceutil/trace.go:171","msg":"trace[1342320034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9114; }","duration":"246.148785ms","start":"2026-09-12T06:52:47.633522Z","end":"2026-09-12T06:52:47.879671Z","steps":["trace[1342320034] 'agreement among raft nodes before linearized reading'  (duration: 245.963891ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:52:47.879872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.371471ms","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-09-12T06:52:47.879912Z","caller":"traceutil/trace.go:171","msg":"trace[1869931524] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9114; }","duration":"121.460643ms","start":"2026-09-12T06:52:47.758442Z","end":"2026-09-12T06:52:47.879903Z","steps":["trace[1869931524] 'agreement among raft nodes before linearized reading'  (duration: 121.369661ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:52:50.861061Z","caller":"traceutil/trace.go:171","msg":"trace[1286222807] transaction","detail":"{read_only:false; response_revision:9134; number_of_response:1; }","duration":"104.74917ms","start":"2026-09-12T06:52:50.756285Z","end":"2026-09-12T06:52:50.861034Z","steps":["trace[1286222807] 'process raft request'  (duration: 104.568736ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:00.138171Z","caller":"traceutil/trace.go:171","msg":"trace[379937169] linearizableReadLoop","detail":"{readStateIndex:9507; appliedIndex:9506; }","duration":"188.11276ms","start":"2026-09-12T06:52:59.950037Z","end":"2026-09-12T06:53:00.138149Z","steps":["trace[379937169] 'read index received'  (duration: 188.051839ms)","trace[379937169] 'applied index is now lower than readState.Index'  (duration: 59.791µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:53:00.13828Z","caller":"traceutil/trace.go:171","msg":"trace[1973524924] transaction","detail":"{read_only:false; response_revision:9178; number_of_response:1; }","duration":"205.468136ms","start":"2026-09-12T06:52:59.932769Z","end":"2026-09-12T06:53:00.138238Z","steps":["trace[1973524924] 'process raft request'  (duration: 205.234711ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:53:00.138368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.317034ms","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-09-12T06:53:00.138402Z","caller":"traceutil/trace.go:171","msg":"trace[874199835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9178; }","duration":"188.431456ms","start":"2026-09-12T06:52:59.949961Z","end":"2026-09-12T06:53:00.138392Z","steps":["trace[874199835] 'agreement among raft nodes before linearized reading'  (duration: 188.288673ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:53:00.209771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.074666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-09-12T06:53:00.209771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.550192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s2lp4\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-09-12T06:53:00.209857Z","caller":"traceutil/trace.go:171","msg":"trace[898187826] transaction","detail":"{read_only:false; response_revision:9179; number_of_response:1; }","duration":"258.709451ms","start":"2026-09-12T06:52:59.951129Z","end":"2026-09-12T06:53:00.209838Z","steps":["trace[898187826] 'process raft request'  (duration: 255.959113ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:00.209879Z","caller":"traceutil/trace.go:171","msg":"trace[1212578353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9179; }","duration":"249.22846ms","start":"2026-09-12T06:52:59.960611Z","end":"2026-09-12T06:53:00.209839Z","steps":["trace[1212578353] 'agreement among raft nodes before linearized reading'  (duration: 248.992824ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:00.209858Z","caller":"traceutil/trace.go:171","msg":"trace[508677738] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s2lp4; range_end:; response_count:1; response_revision:9179; }","duration":"172.702605ms","start":"2026-09-12T06:53:00.037141Z","end":"2026-09-12T06:53:00.209844Z","steps":["trace[508677738] 'agreement among raft nodes before linearized reading'  (duration: 172.50581ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:53:00.209912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.795009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T06:53:00.209999Z","caller":"traceutil/trace.go:171","msg":"trace[1172926168] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:9179; }","duration":"228.963503ms","start":"2026-09-12T06:52:59.981017Z","end":"2026-09-12T06:53:00.20998Z","steps":["trace[1172926168] 'agreement among raft nodes before linearized reading'  (duration: 228.762028ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:53:00.209801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.374665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-09-12T06:53:00.209966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.316821ms","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-09-12T06:53:00.210034Z","caller":"traceutil/trace.go:171","msg":"trace[166344427] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9179; }","duration":"187.644701ms","start":"2026-09-12T06:53:00.02238Z","end":"2026-09-12T06:53:00.210025Z","steps":["trace[166344427] 'agreement among raft nodes before linearized reading'  (duration: 187.345674ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:00.21007Z","caller":"traceutil/trace.go:171","msg":"trace[1505338322] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9179; }","duration":"212.533896ms","start":"2026-09-12T06:52:59.997511Z","end":"2026-09-12T06:53:00.210045Z","steps":["trace[1505338322] 'agreement among raft nodes before linearized reading'  (duration: 212.190778ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:00.66007Z","caller":"traceutil/trace.go:171","msg":"trace[580806727] transaction","detail":"{read_only:false; response_revision:9185; number_of_response:1; }","duration":"103.430463ms","start":"2026-09-12T06:53:00.556612Z","end":"2026-09-12T06:53:00.660043Z","steps":["trace[580806727] 'process raft request'  (duration: 103.27909ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:00.701626Z","caller":"traceutil/trace.go:171","msg":"trace[35946263] transaction","detail":"{read_only:false; response_revision:9186; number_of_response:1; }","duration":"144.657233ms","start":"2026-09-12T06:53:00.556928Z","end":"2026-09-12T06:53:00.701585Z","steps":["trace[35946263] 'process raft request'  (duration: 144.409668ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:53:00.868783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.163205ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452674146 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:9104 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-12T06:53:00.869112Z","caller":"traceutil/trace.go:171","msg":"trace[369513015] transaction","detail":"{read_only:false; response_revision:9187; number_of_response:1; }","duration":"166.937284ms","start":"2026-09-12T06:53:00.702138Z","end":"2026-09-12T06:53:00.869075Z","steps":["trace[369513015] 'process raft request'  (duration: 37.35557ms)","trace[369513015] 'compare'  (duration: 128.968601ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:53:14.388247Z","caller":"traceutil/trace.go:171","msg":"trace[759442346] transaction","detail":"{read_only:false; response_revision:9326; number_of_response:1; }","duration":"116.510049ms","start":"2026-09-12T06:53:14.2717Z","end":"2026-09-12T06:53:14.38821Z","steps":["trace[759442346] 'process raft request'  (duration: 19.626734ms)","trace[759442346] 'compare'  (duration: 96.656121ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:53:14.388707Z","caller":"traceutil/trace.go:171","msg":"trace[1736139607] linearizableReadLoop","detail":"{readStateIndex:9663; appliedIndex:9660; }","duration":"103.322241ms","start":"2026-09-12T06:53:14.285352Z","end":"2026-09-12T06:53:14.388674Z","steps":["trace[1736139607] 'read index received'  (duration: 5.911505ms)","trace[1736139607] 'applied index is now lower than readState.Index'  (duration: 97.409496ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T06:53:14.388809Z","caller":"traceutil/trace.go:171","msg":"trace[246536454] transaction","detail":"{read_only:false; response_revision:9327; number_of_response:1; }","duration":"116.13715ms","start":"2026-09-12T06:53:14.27265Z","end":"2026-09-12T06:53:14.388787Z","steps":["trace[246536454] 'process raft request'  (duration: 115.512317ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:14.388838Z","caller":"traceutil/trace.go:171","msg":"trace[959804494] transaction","detail":"{read_only:false; response_revision:9328; number_of_response:1; }","duration":"113.168289ms","start":"2026-09-12T06:53:14.275633Z","end":"2026-09-12T06:53:14.388801Z","steps":["trace[959804494] 'process raft request'  (duration: 112.890623ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T06:53:14.389043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.679528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ceph-object-controller-detect-version-t5hwr\" ","response":"range_response_count:1 size:4558"}
{"level":"info","ts":"2026-09-12T06:53:14.389114Z","caller":"traceutil/trace.go:171","msg":"trace[761657224] range","detail":"{range_begin:/registry/pods/openstack/ceph-object-controller-detect-version-t5hwr; range_end:; response_count:1; response_revision:9328; }","duration":"103.798171ms","start":"2026-09-12T06:53:14.285299Z","end":"2026-09-12T06:53:14.389097Z","steps":["trace[761657224] 'agreement among raft nodes before linearized reading'  (duration: 103.547446ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:53:52.552691Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51815f4ecef28267","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T06:53:52.562958Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-12T06:53:52.563054Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-12T06:54:33.589927Z","caller":"traceutil/trace.go:171","msg":"trace[1951318779] transaction","detail":"{read_only:false; response_revision:10060; number_of_response:1; }","duration":"236.765549ms","start":"2026-09-12T06:54:33.35312Z","end":"2026-09-12T06:54:33.589885Z","steps":["trace[1951318779] 'process raft request'  (duration: 236.497924ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T06:55:13.040787Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7967}
{"level":"info","ts":"2026-09-12T06:55:13.117215Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7967,"took":"73.519215ms","hash":2710051115,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":28176384,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-12T06:55:13.117395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2710051115,"revision":7967,"compact-revision":5648}
{"level":"info","ts":"2026-09-12T06:58:50.625763Z","caller":"traceutil/trace.go:171","msg":"trace[844596494] transaction","detail":"{read_only:false; response_revision:11700; number_of_response:1; }","duration":"157.768271ms","start":"2026-09-12T06:58:50.467956Z","end":"2026-09-12T06:58:50.625724Z","steps":["trace[844596494] 'process raft request'  (duration: 157.392453ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:00:13.04915Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10341}
{"level":"info","ts":"2026-09-12T07:00:13.14135Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10341,"took":"89.314696ms","hash":3587241996,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":25571328,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-12T07:00:13.141447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3587241996,"revision":10341,"compact-revision":7967}
{"level":"info","ts":"2026-09-12T07:00:19.767137Z","caller":"traceutil/trace.go:171","msg":"trace[1045880319] transaction","detail":"{read_only:false; response_revision:12527; number_of_response:1; }","duration":"101.918914ms","start":"2026-09-12T07:00:19.665181Z","end":"2026-09-12T07:00:19.7671Z","steps":["trace[1045880319] 'process raft request'  (duration: 101.588276ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:00:20.900273Z","caller":"traceutil/trace.go:171","msg":"trace[1614598619] transaction","detail":"{read_only:false; response_revision:12532; number_of_response:1; }","duration":"129.794876ms","start":"2026-09-12T07:00:20.770423Z","end":"2026-09-12T07:00:20.900218Z","steps":["trace[1614598619] 'process raft request'  (duration: 129.180513ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:05:13.060516Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12488}
{"level":"info","ts":"2026-09-12T07:05:13.160087Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12488,"took":"97.026466ms","hash":1017286464,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":27365376,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-12T07:05:13.160173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1017286464,"revision":12488,"compact-revision":10341}
{"level":"info","ts":"2026-09-12T07:07:28.299523Z","caller":"traceutil/trace.go:171","msg":"trace[567087858] transaction","detail":"{read_only:false; response_revision:15370; number_of_response:1; }","duration":"127.162147ms","start":"2026-09-12T07:07:28.172334Z","end":"2026-09-12T07:07:28.299496Z","steps":["trace[567087858] 'process raft request'  (duration: 127.103586ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:07:28.29974Z","caller":"traceutil/trace.go:171","msg":"trace[366152836] transaction","detail":"{read_only:false; response_revision:15368; number_of_response:1; }","duration":"177.398707ms","start":"2026-09-12T07:07:28.122325Z","end":"2026-09-12T07:07:28.299724Z","steps":["trace[366152836] 'process raft request'  (duration: 157.472443ms)","trace[366152836] 'compare'  (duration: 19.27146ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:07:28.299855Z","caller":"traceutil/trace.go:171","msg":"trace[1618216806] transaction","detail":"{read_only:false; response_revision:15369; number_of_response:1; }","duration":"160.909675ms","start":"2026-09-12T07:07:28.138927Z","end":"2026-09-12T07:07:28.299836Z","steps":["trace[1618216806] 'process raft request'  (duration: 160.435225ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:07:29.211308Z","caller":"traceutil/trace.go:171","msg":"trace[265712700] transaction","detail":"{read_only:false; response_revision:15371; number_of_response:1; }","duration":"137.629641ms","start":"2026-09-12T07:07:29.07364Z","end":"2026-09-12T07:07:29.21127Z","steps":["trace[265712700] 'process raft request'  (duration: 137.356265ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:07:54.107761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.52476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-gp6qf\" ","response":"range_response_count:1 size:20640"}
{"level":"info","ts":"2026-09-12T07:07:54.107979Z","caller":"traceutil/trace.go:171","msg":"trace[269648239] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-gp6qf; range_end:; response_count:1; response_revision:15693; }","duration":"177.767656ms","start":"2026-09-12T07:07:53.930159Z","end":"2026-09-12T07:07:54.107927Z","steps":["trace[269648239] 'range keys from in-memory index tree'  (duration: 177.160983ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:07:54.107938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.436866ms","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-09-12T07:07:54.108091Z","caller":"traceutil/trace.go:171","msg":"trace[1252512454] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15693; }","duration":"299.627879ms","start":"2026-09-12T07:07:53.808416Z","end":"2026-09-12T07:07:54.108044Z","steps":["trace[1252512454] 'range keys from in-memory index tree'  (duration: 299.194881ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:07:54.107758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.520794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T07:07:54.108351Z","caller":"traceutil/trace.go:171","msg":"trace[1533591685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15693; }","duration":"173.150987ms","start":"2026-09-12T07:07:53.935162Z","end":"2026-09-12T07:07:54.108313Z","steps":["trace[1533591685] 'range keys from in-memory index tree'  (duration: 172.33849ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:07:54.176274Z","caller":"traceutil/trace.go:171","msg":"trace[1324375304] linearizableReadLoop","detail":"{readStateIndex:16248; appliedIndex:16247; }","duration":"139.814757ms","start":"2026-09-12T07:07:54.036426Z","end":"2026-09-12T07:07:54.176241Z","steps":["trace[1324375304] 'read index received'  (duration: 139.51785ms)","trace[1324375304] 'applied index is now lower than readState.Index'  (duration: 295.407µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:07:54.176427Z","caller":"traceutil/trace.go:171","msg":"trace[786789895] transaction","detail":"{read_only:false; response_revision:15694; number_of_response:1; }","duration":"200.499608ms","start":"2026-09-12T07:07:53.975825Z","end":"2026-09-12T07:07:54.176325Z","steps":["trace[786789895] 'process raft request'  (duration: 200.197922ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:07:54.176587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.138284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-12T07:07:54.176634Z","caller":"traceutil/trace.go:171","msg":"trace[285457214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15694; }","duration":"140.292777ms","start":"2026-09-12T07:07:54.03633Z","end":"2026-09-12T07:07:54.176623Z","steps":["trace[285457214] 'agreement among raft nodes before linearized reading'  (duration: 140.070842ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:07:54.178111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.80102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-12T07:07:54.178217Z","caller":"traceutil/trace.go:171","msg":"trace[620630432] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:15695; }","duration":"134.961394ms","start":"2026-09-12T07:07:54.043226Z","end":"2026-09-12T07:07:54.178187Z","steps":["trace[620630432] 'agreement among raft nodes before linearized reading'  (duration: 134.765579ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:07:54.180144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.065762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-12T07:07:54.180278Z","caller":"traceutil/trace.go:171","msg":"trace[652514996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15695; }","duration":"135.032226ms","start":"2026-09-12T07:07:54.045223Z","end":"2026-09-12T07:07:54.180255Z","steps":["trace[652514996] 'agreement among raft nodes before linearized reading'  (duration: 132.938301ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:09:22.288147Z","caller":"traceutil/trace.go:171","msg":"trace[2116826285] linearizableReadLoop","detail":"{readStateIndex:17092; appliedIndex:17091; }","duration":"124.770003ms","start":"2026-09-12T07:09:22.16332Z","end":"2026-09-12T07:09:22.28809Z","steps":["trace[2116826285] 'read index received'  (duration: 124.60228ms)","trace[2116826285] 'applied index is now lower than readState.Index'  (duration: 166.373µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:09:22.288228Z","caller":"traceutil/trace.go:171","msg":"trace[1514601321] transaction","detail":"{read_only:false; response_revision:16514; number_of_response:1; }","duration":"138.039287ms","start":"2026-09-12T07:09:22.150125Z","end":"2026-09-12T07:09:22.288164Z","steps":["trace[1514601321] 'process raft request'  (duration: 137.752221ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:09:22.288401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.020818ms","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-09-12T07:09:22.288463Z","caller":"traceutil/trace.go:171","msg":"trace[1654811072] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:16514; }","duration":"125.158713ms","start":"2026-09-12T07:09:22.163286Z","end":"2026-09-12T07:09:22.288445Z","steps":["trace[1654811072] 'agreement among raft nodes before linearized reading'  (duration: 125.009068ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:09:22.288575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.082744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:09:22.288634Z","caller":"traceutil/trace.go:171","msg":"trace[1545959038] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16514; }","duration":"120.219566ms","start":"2026-09-12T07:09:22.168398Z","end":"2026-09-12T07:09:22.288617Z","steps":["trace[1545959038] 'agreement among raft nodes before linearized reading'  (duration: 120.090614ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:09:22.288901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.663412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:09:22.288943Z","caller":"traceutil/trace.go:171","msg":"trace[1083457545] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16514; }","duration":"117.710523ms","start":"2026-09-12T07:09:22.171222Z","end":"2026-09-12T07:09:22.288933Z","steps":["trace[1083457545] 'agreement among raft nodes before linearized reading'  (duration: 117.644531ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:09:22.288844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.221162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:09:22.28903Z","caller":"traceutil/trace.go:171","msg":"trace[1528383017] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16514; }","duration":"117.476108ms","start":"2026-09-12T07:09:22.171528Z","end":"2026-09-12T07:09:22.289004Z","steps":["trace[1528383017] 'agreement among raft nodes before linearized reading'  (duration: 117.235543ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:09:22.289153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.465448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-09-12T07:09:22.289191Z","caller":"traceutil/trace.go:171","msg":"trace[1398159160] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16514; }","duration":"117.56982ms","start":"2026-09-12T07:09:22.17161Z","end":"2026-09-12T07:09:22.28918Z","steps":["trace[1398159160] 'agreement among raft nodes before linearized reading'  (duration: 117.413447ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:10:13.066987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14539}
{"level":"info","ts":"2026-09-12T07:10:13.159083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14539,"took":"88.003979ms","hash":4020004368,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":29491200,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T07:10:13.159468Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4020004368,"revision":14539,"compact-revision":12488}
{"level":"info","ts":"2026-09-12T07:15:13.07395Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16820}
{"level":"info","ts":"2026-09-12T07:15:13.182502Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16820,"took":"105.393078ms","hash":3426120013,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":30584832,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-12T07:15:13.182678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3426120013,"revision":16820,"compact-revision":14539}
{"level":"info","ts":"2026-09-12T07:16:02.293235Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51815f4ecef28267","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T07:16:02.299834Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-12T07:16:02.299953Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-09-12T07:16:17.726316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.031876ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452706699 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:19427 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:16:17.726598Z","caller":"traceutil/trace.go:171","msg":"trace[1676504352] transaction","detail":"{read_only:false; response_revision:19444; number_of_response:1; }","duration":"142.259534ms","start":"2026-09-12T07:16:17.584313Z","end":"2026-09-12T07:16:17.726573Z","steps":["trace[1676504352] 'process raft request'  (duration: 142.135902ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:16:17.726894Z","caller":"traceutil/trace.go:171","msg":"trace[2066563602] transaction","detail":"{read_only:false; response_revision:19443; number_of_response:1; }","duration":"389.025718ms","start":"2026-09-12T07:16:17.337851Z","end":"2026-09-12T07:16:17.726877Z","steps":["trace[2066563602] 'process raft request'  (duration: 219.304147ms)","trace[2066563602] 'compare'  (duration: 168.631707ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:16:17.726957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:16:17.337829Z","time spent":"389.089789ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:19427 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-09-12T07:20:13.082933Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19000}
{"level":"info","ts":"2026-09-12T07:20:13.186979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19000,"took":"99.846411ms","hash":2702319782,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":33677312,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-12T07:20:13.187064Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2702319782,"revision":19000,"compact-revision":16820}
{"level":"info","ts":"2026-09-12T07:22:38.945092Z","caller":"traceutil/trace.go:171","msg":"trace[159196602] transaction","detail":"{read_only:false; response_revision:22336; number_of_response:1; }","duration":"118.282174ms","start":"2026-09-12T07:22:38.826751Z","end":"2026-09-12T07:22:38.945033Z","steps":["trace[159196602] 'process raft request'  (duration: 117.952037ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:22:55.381914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.481308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T07:22:55.382124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.623472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-09-12T07:22:55.382215Z","caller":"traceutil/trace.go:171","msg":"trace[596057988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22417; }","duration":"187.781285ms","start":"2026-09-12T07:22:55.194407Z","end":"2026-09-12T07:22:55.382188Z","steps":["trace[596057988] 'range keys from in-memory index tree'  (duration: 187.343466ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:22:55.382135Z","caller":"traceutil/trace.go:171","msg":"trace[1461583877] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:22417; }","duration":"156.731594ms","start":"2026-09-12T07:22:55.225347Z","end":"2026-09-12T07:22:55.382079Z","steps":["trace[1461583877] 'count revisions from in-memory index tree'  (duration: 156.400297ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:22:56.056463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.760238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:22:56.056559Z","caller":"traceutil/trace.go:171","msg":"trace[1158216669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22420; }","duration":"121.918251ms","start":"2026-09-12T07:22:55.934617Z","end":"2026-09-12T07:22:56.056535Z","steps":["trace[1158216669] 'range keys from in-memory index tree'  (duration: 121.605263ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:25:13.090651Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21302}
{"level":"info","ts":"2026-09-12T07:25:13.214107Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21302,"took":"116.937345ms","hash":2880459627,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":30208000,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T07:25:13.214168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2880459627,"revision":21302,"compact-revision":19000}
{"level":"info","ts":"2026-09-12T07:27:11.848417Z","caller":"traceutil/trace.go:171","msg":"trace[1328417388] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"288.650448ms","start":"2026-09-12T07:27:11.559626Z","end":"2026-09-12T07:27:11.848277Z","steps":["trace[1328417388] 'process raft request'  (duration: 288.248989ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:27:11.854547Z","caller":"traceutil/trace.go:171","msg":"trace[1174359580] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"283.836436ms","start":"2026-09-12T07:27:11.570671Z","end":"2026-09-12T07:27:11.854507Z","steps":["trace[1174359580] 'process raft request'  (duration: 283.582641ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:27:11.854611Z","caller":"traceutil/trace.go:171","msg":"trace[747644411] transaction","detail":"{read_only:false; response_revision:24992; number_of_response:1; }","duration":"272.923823ms","start":"2026-09-12T07:27:11.581638Z","end":"2026-09-12T07:27:11.854562Z","steps":["trace[747644411] 'process raft request'  (duration: 272.77336ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:27:11.877378Z","caller":"traceutil/trace.go:171","msg":"trace[2144103158] transaction","detail":"{read_only:false; response_revision:24993; number_of_response:1; }","duration":"104.99362ms","start":"2026-09-12T07:27:11.772348Z","end":"2026-09-12T07:27:11.877342Z","steps":["trace[2144103158] 'process raft request'  (duration: 104.332566ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:28:48.524667Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068f7.wal"}
{"level":"info","ts":"2026-09-12T07:30:13.09723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23542}
{"level":"info","ts":"2026-09-12T07:30:13.224665Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23542,"took":"123.578923ms","hash":1940470834,"current-db-size-bytes":56659968,"current-db-size":"57 MB","current-db-size-in-use-bytes":44785664,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-09-12T07:30:13.224724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1940470834,"revision":23542,"compact-revision":21302}
{"level":"info","ts":"2026-09-12T07:30:56.503504Z","caller":"traceutil/trace.go:171","msg":"trace[702334160] transaction","detail":"{read_only:false; response_revision:27221; number_of_response:1; }","duration":"267.834367ms","start":"2026-09-12T07:30:56.23563Z","end":"2026-09-12T07:30:56.503464Z","steps":["trace[702334160] 'process raft request'  (duration: 267.325296ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:30:56.503659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.52701ms","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-09-12T07:30:56.503698Z","caller":"traceutil/trace.go:171","msg":"trace[903633590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27221; }","duration":"152.579091ms","start":"2026-09-12T07:30:56.351108Z","end":"2026-09-12T07:30:56.503687Z","steps":["trace[903633590] 'agreement among raft nodes before linearized reading'  (duration: 152.397587ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:30:56.503991Z","caller":"traceutil/trace.go:171","msg":"trace[1256199101] linearizableReadLoop","detail":"{readStateIndex:28135; appliedIndex:28134; }","duration":"152.205623ms","start":"2026-09-12T07:30:56.351116Z","end":"2026-09-12T07:30:56.503322Z","steps":["trace[1256199101] 'read index received'  (duration: 151.726463ms)","trace[1256199101] 'applied index is now lower than readState.Index'  (duration: 478.24µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:30:56.621883Z","caller":"traceutil/trace.go:171","msg":"trace[964978536] linearizableReadLoop","detail":"{readStateIndex:28136; appliedIndex:28135; }","duration":"117.838121ms","start":"2026-09-12T07:30:56.504015Z","end":"2026-09-12T07:30:56.621853Z","steps":["trace[964978536] 'read index received'  (duration: 117.436722ms)","trace[964978536] 'applied index is now lower than readState.Index'  (duration: 400.379µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:30:56.621924Z","caller":"traceutil/trace.go:171","msg":"trace[1373448996] transaction","detail":"{read_only:false; response_revision:27222; number_of_response:1; }","duration":"199.538572ms","start":"2026-09-12T07:30:56.422357Z","end":"2026-09-12T07:30:56.621896Z","steps":["trace[1373448996] 'process raft request'  (duration: 199.079562ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:30:56.622226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.723518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.58\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-09-12T07:30:56.622273Z","caller":"traceutil/trace.go:171","msg":"trace[65836752] range","detail":"{range_begin:/registry/masterleases/162.253.55.58; range_end:; response_count:1; response_revision:27222; }","duration":"209.815161ms","start":"2026-09-12T07:30:56.412446Z","end":"2026-09-12T07:30:56.622261Z","steps":["trace[65836752] 'agreement among raft nodes before linearized reading'  (duration: 209.642717ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:30:56.658484Z","caller":"traceutil/trace.go:171","msg":"trace[890104474] transaction","detail":"{read_only:false; response_revision:27223; number_of_response:1; }","duration":"150.958107ms","start":"2026-09-12T07:30:56.50749Z","end":"2026-09-12T07:30:56.658448Z","steps":["trace[890104474] 'process raft request'  (duration: 150.714852ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:30:56.658528Z","caller":"traceutil/trace.go:171","msg":"trace[552228316] transaction","detail":"{read_only:false; response_revision:27224; number_of_response:1; }","duration":"134.137568ms","start":"2026-09-12T07:30:56.524348Z","end":"2026-09-12T07:30:56.658486Z","steps":["trace[552228316] 'process raft request'  (duration: 134.004205ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:01.141586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.317898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:01.141657Z","caller":"traceutil/trace.go:171","msg":"trace[1426776286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27254; }","duration":"123.43256ms","start":"2026-09-12T07:31:01.018207Z","end":"2026-09-12T07:31:01.141639Z","steps":["trace[1426776286] 'range keys from in-memory index tree'  (duration: 123.220726ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:01.141882Z","caller":"traceutil/trace.go:171","msg":"trace[304050851] transaction","detail":"{read_only:false; response_revision:27255; number_of_response:1; }","duration":"122.318157ms","start":"2026-09-12T07:31:01.019555Z","end":"2026-09-12T07:31:01.141873Z","steps":["trace[304050851] 'process raft request'  (duration: 121.9652ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:01.141852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.186378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:01.14201Z","caller":"traceutil/trace.go:171","msg":"trace[118469575] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:27254; }","duration":"141.399083ms","start":"2026-09-12T07:31:01.000588Z","end":"2026-09-12T07:31:01.141987Z","steps":["trace[118469575] 'count revisions from in-memory index tree'  (duration: 141.057305ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:01.143388Z","caller":"traceutil/trace.go:171","msg":"trace[535441859] transaction","detail":"{read_only:false; response_revision:27256; number_of_response:1; }","duration":"123.054063ms","start":"2026-09-12T07:31:01.020314Z","end":"2026-09-12T07:31:01.143369Z","steps":["trace[535441859] 'process raft request'  (duration: 122.91251ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:01.399838Z","caller":"traceutil/trace.go:171","msg":"trace[1947416095] transaction","detail":"{read_only:false; response_revision:27257; number_of_response:1; }","duration":"141.153327ms","start":"2026-09-12T07:31:01.258646Z","end":"2026-09-12T07:31:01.3998Z","steps":["trace[1947416095] 'process raft request'  (duration: 112.875155ms)","trace[1947416095] 'compare'  (duration: 28.034637ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:01.435033Z","caller":"traceutil/trace.go:171","msg":"trace[113826808] linearizableReadLoop","detail":"{readStateIndex:28173; appliedIndex:28171; }","duration":"114.083782ms","start":"2026-09-12T07:31:01.320911Z","end":"2026-09-12T07:31:01.434995Z","steps":["trace[113826808] 'read index received'  (duration: 50.625759ms)","trace[113826808] 'applied index is now lower than readState.Index'  (duration: 63.456332ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:01.435206Z","caller":"traceutil/trace.go:171","msg":"trace[250891269] transaction","detail":"{read_only:false; response_revision:27258; number_of_response:1; }","duration":"173.569629ms","start":"2026-09-12T07:31:01.261577Z","end":"2026-09-12T07:31:01.435146Z","steps":["trace[250891269] 'process raft request'  (duration: 173.224261ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:01.435378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.448779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-12T07:31:01.435457Z","caller":"traceutil/trace.go:171","msg":"trace[1992331900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27258; }","duration":"114.568211ms","start":"2026-09-12T07:31:01.320872Z","end":"2026-09-12T07:31:01.43544Z","steps":["trace[1992331900] 'agreement among raft nodes before linearized reading'  (duration: 114.342036ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:01.607556Z","caller":"traceutil/trace.go:171","msg":"trace[1635804585] transaction","detail":"{read_only:false; response_revision:27259; number_of_response:1; }","duration":"167.389236ms","start":"2026-09-12T07:31:01.440129Z","end":"2026-09-12T07:31:01.607518Z","steps":["trace[1635804585] 'process raft request'  (duration: 167.223642ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:01.814738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.507325ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452727998 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:27246 > 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-09-12T07:31:01.814996Z","caller":"traceutil/trace.go:171","msg":"trace[1629994987] transaction","detail":"{read_only:false; response_revision:27260; number_of_response:1; }","duration":"340.054245ms","start":"2026-09-12T07:31:01.47491Z","end":"2026-09-12T07:31:01.814964Z","steps":["trace[1629994987] 'process raft request'  (duration: 236.213983ms)","trace[1629994987] 'compare'  (duration: 103.342422ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:01.815178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:01.47489Z","time spent":"340.206669ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:27246 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-09-12T07:31:02.144096Z","caller":"traceutil/trace.go:171","msg":"trace[1804750331] transaction","detail":"{read_only:false; response_revision:27261; number_of_response:1; }","duration":"100.116394ms","start":"2026-09-12T07:31:02.043924Z","end":"2026-09-12T07:31:02.144041Z","steps":["trace[1804750331] 'process raft request'  (duration: 99.844388ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:02.324982Z","caller":"traceutil/trace.go:171","msg":"trace[911168664] transaction","detail":"{read_only:false; response_revision:27262; number_of_response:1; }","duration":"114.911419ms","start":"2026-09-12T07:31:02.210027Z","end":"2026-09-12T07:31:02.324938Z","steps":["trace[911168664] 'process raft request'  (duration: 111.548498ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:02.720954Z","caller":"traceutil/trace.go:171","msg":"trace[1714198590] linearizableReadLoop","detail":"{readStateIndex:28180; appliedIndex:28179; }","duration":"251.413827ms","start":"2026-09-12T07:31:02.46952Z","end":"2026-09-12T07:31:02.720933Z","steps":["trace[1714198590] 'read index received'  (duration: 251.391507ms)","trace[1714198590] 'applied index is now lower than readState.Index'  (duration: 21.2µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:02.721104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.53721ms","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-09-12T07:31:02.721123Z","caller":"traceutil/trace.go:171","msg":"trace[1622449359] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27264; }","duration":"251.643602ms","start":"2026-09-12T07:31:02.469473Z","end":"2026-09-12T07:31:02.721117Z","steps":["trace[1622449359] 'agreement among raft nodes before linearized reading'  (duration: 251.55446ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:02.721269Z","caller":"traceutil/trace.go:171","msg":"trace[1518340439] transaction","detail":"{read_only:false; response_revision:27264; number_of_response:1; }","duration":"263.234599ms","start":"2026-09-12T07:31:02.457799Z","end":"2026-09-12T07:31:02.721033Z","steps":["trace[1518340439] 'process raft request'  (duration: 263.024295ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.089844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.003453ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728010 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:27249 > 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-09-12T07:31:03.089998Z","caller":"traceutil/trace.go:171","msg":"trace[1553909667] linearizableReadLoop","detail":"{readStateIndex:28182; appliedIndex:28180; }","duration":"368.971942ms","start":"2026-09-12T07:31:02.721011Z","end":"2026-09-12T07:31:03.089983Z","steps":["trace[1553909667] 'read index received'  (duration: 136.690803ms)","trace[1553909667] 'applied index is now lower than readState.Index'  (duration: 232.280069ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:03.090024Z","caller":"traceutil/trace.go:171","msg":"trace[248806854] transaction","detail":"{read_only:false; response_revision:27266; number_of_response:1; }","duration":"445.231206ms","start":"2026-09-12T07:31:02.64478Z","end":"2026-09-12T07:31:03.090011Z","steps":["trace[248806854] 'process raft request'  (duration: 445.159495ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.090096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:02.644753Z","time spent":"445.296868ms","remote":"127.0.0.1:59826","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:27250 > 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-09-12T07:31:03.090112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.263965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T07:31:03.090135Z","caller":"traceutil/trace.go:171","msg":"trace[330718544] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:27266; }","duration":"435.341018ms","start":"2026-09-12T07:31:02.654786Z","end":"2026-09-12T07:31:03.090127Z","steps":["trace[330718544] 'agreement among raft nodes before linearized reading'  (duration: 435.291027ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.090163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:02.654774Z","time spent":"435.381538ms","remote":"127.0.0.1:59984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-09-12T07:31:03.090159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.900107ms","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-09-12T07:31:03.090141Z","caller":"traceutil/trace.go:171","msg":"trace[101166090] transaction","detail":"{read_only:false; response_revision:27265; number_of_response:1; }","duration":"567.732968ms","start":"2026-09-12T07:31:02.522361Z","end":"2026-09-12T07:31:03.090094Z","steps":["trace[101166090] 'process raft request'  (duration: 335.415638ms)","trace[101166090] 'compare'  (duration: 231.91074ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:03.090267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.716438ms","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-09-12T07:31:03.09029Z","caller":"traceutil/trace.go:171","msg":"trace[321307045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27266; }","duration":"124.771059ms","start":"2026-09-12T07:31:02.965513Z","end":"2026-09-12T07:31:03.090284Z","steps":["trace[321307045] 'agreement among raft nodes before linearized reading'  (duration: 124.708328ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.090272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.675832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T07:31:03.090317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:02.522323Z","time spent":"567.905132ms","remote":"127.0.0.1:59826","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:27249 > 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-09-12T07:31:03.090336Z","caller":"traceutil/trace.go:171","msg":"trace[286979569] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27266; }","duration":"365.743374ms","start":"2026-09-12T07:31:02.724576Z","end":"2026-09-12T07:31:03.09032Z","steps":["trace[286979569] 'agreement among raft nodes before linearized reading'  (duration: 365.643362ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.09034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.111327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T07:31:03.090368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:02.724531Z","time spent":"365.830096ms","remote":"127.0.0.1:59744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-09-12T07:31:03.090373Z","caller":"traceutil/trace.go:171","msg":"trace[317610100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27266; }","duration":"156.180049ms","start":"2026-09-12T07:31:02.934186Z","end":"2026-09-12T07:31:03.090366Z","steps":["trace[317610100] 'agreement among raft nodes before linearized reading'  (duration: 156.133618ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.090439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.204997ms","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-09-12T07:31:03.09046Z","caller":"traceutil/trace.go:171","msg":"trace[1956838193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27266; }","duration":"124.238639ms","start":"2026-09-12T07:31:02.966216Z","end":"2026-09-12T07:31:03.090455Z","steps":["trace[1956838193] 'agreement among raft nodes before linearized reading'  (duration: 124.176527ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:03.090191Z","caller":"traceutil/trace.go:171","msg":"trace[1658930647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27266; }","duration":"388.972579ms","start":"2026-09-12T07:31:02.701209Z","end":"2026-09-12T07:31:03.090181Z","steps":["trace[1658930647] 'agreement among raft nodes before linearized reading'  (duration: 388.822145ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.090645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.065807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-09-12T07:31:03.090635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:02.701191Z","time spent":"389.416298ms","remote":"127.0.0.1:59826","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-09-12T07:31:03.09072Z","caller":"traceutil/trace.go:171","msg":"trace[1428585318] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:27266; }","duration":"249.101088ms","start":"2026-09-12T07:31:02.841567Z","end":"2026-09-12T07:31:03.090668Z","steps":["trace[1428585318] 'agreement among raft nodes before linearized reading'  (duration: 248.995626ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.46391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.299323ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728016 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:27251 > 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-09-12T07:31:03.464187Z","caller":"traceutil/trace.go:171","msg":"trace[95322067] transaction","detail":"{read_only:false; response_revision:27268; number_of_response:1; }","duration":"369.859011ms","start":"2026-09-12T07:31:03.094307Z","end":"2026-09-12T07:31:03.464166Z","steps":["trace[95322067] 'process raft request'  (duration: 181.207291ms)","trace[95322067] 'compare'  (duration: 188.046007ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:03.464249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.094268Z","time spent":"369.951353ms","remote":"127.0.0.1:59826","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:27251 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-12T07:31:03.464353Z","caller":"traceutil/trace.go:171","msg":"trace[1241086026] linearizableReadLoop","detail":"{readStateIndex:28185; appliedIndex:28183; }","duration":"368.548253ms","start":"2026-09-12T07:31:03.095776Z","end":"2026-09-12T07:31:03.464324Z","steps":["trace[1241086026] 'read index received'  (duration: 33.304079ms)","trace[1241086026] 'applied index is now lower than readState.Index'  (duration: 335.242753ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:03.464399Z","caller":"traceutil/trace.go:171","msg":"trace[470513016] transaction","detail":"{read_only:false; response_revision:27269; number_of_response:1; }","duration":"370.002575ms","start":"2026-09-12T07:31:03.094375Z","end":"2026-09-12T07:31:03.464377Z","steps":["trace[470513016] 'process raft request'  (duration: 369.665398ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.464483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.094352Z","time spent":"370.075356ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:27253 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-12T07:31:03.464612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.814929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-09-12T07:31:03.46472Z","caller":"traceutil/trace.go:171","msg":"trace[547886032] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27269; }","duration":"368.964051ms","start":"2026-09-12T07:31:03.095737Z","end":"2026-09-12T07:31:03.464702Z","steps":["trace[547886032] 'agreement among raft nodes before linearized reading'  (duration: 368.674915ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.464766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.095726Z","time spent":"369.031903ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-12T07:31:03.877582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.352403ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728019 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:27255 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:31:03.877982Z","caller":"traceutil/trace.go:171","msg":"trace[836037106] transaction","detail":"{read_only:false; response_revision:27270; number_of_response:1; }","duration":"730.420184ms","start":"2026-09-12T07:31:03.147511Z","end":"2026-09-12T07:31:03.877931Z","steps":["trace[836037106] 'process raft request'  (duration: 495.529879ms)","trace[836037106] 'compare'  (duration: 233.952644ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:03.878224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.147469Z","time spent":"730.635268ms","remote":"127.0.0.1:59826","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:27255 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-12T07:31:03.878969Z","caller":"traceutil/trace.go:171","msg":"trace[1585921435] linearizableReadLoop","detail":"{readStateIndex:28189; appliedIndex:28185; }","duration":"412.900987ms","start":"2026-09-12T07:31:03.466045Z","end":"2026-09-12T07:31:03.878946Z","steps":["trace[1585921435] 'read index received'  (duration: 177.044752ms)","trace[1585921435] 'applied index is now lower than readState.Index'  (duration: 235.854745ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:03.879158Z","caller":"traceutil/trace.go:171","msg":"trace[1137820913] transaction","detail":"{read_only:false; response_revision:27272; number_of_response:1; }","duration":"474.625683ms","start":"2026-09-12T07:31:03.404508Z","end":"2026-09-12T07:31:03.879134Z","steps":["trace[1137820913] 'process raft request'  (duration: 474.322217ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:03.879268Z","caller":"traceutil/trace.go:171","msg":"trace[798731215] transaction","detail":"{read_only:false; response_revision:27273; number_of_response:1; }","duration":"439.412014ms","start":"2026-09-12T07:31:03.439843Z","end":"2026-09-12T07:31:03.879255Z","steps":["trace[798731215] 'process raft request'  (duration: 439.052556ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.879354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.439818Z","time spent":"439.489785ms","remote":"127.0.0.1:59826","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/capi-system/controller-leader-election-capi\" mod_revision:27258 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-09-12T07:31:03.879675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.404481Z","time spent":"474.764386ms","remote":"127.0.0.1:59826","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:27257 > 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-09-12T07:31:03.879656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.606652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19026"}
{"level":"info","ts":"2026-09-12T07:31:03.879983Z","caller":"traceutil/trace.go:171","msg":"trace[1765171572] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27273; }","duration":"413.951289ms","start":"2026-09-12T07:31:03.466017Z","end":"2026-09-12T07:31:03.879969Z","steps":["trace[1765171572] 'agreement among raft nodes before linearized reading'  (duration: 413.532261ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.880047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.466002Z","time spent":"414.032711ms","remote":"127.0.0.1:59738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19049,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-09-12T07:31:03.879878Z","caller":"traceutil/trace.go:171","msg":"trace[311988574] transaction","detail":"{read_only:false; response_revision:27271; number_of_response:1; }","duration":"731.21379ms","start":"2026-09-12T07:31:03.148656Z","end":"2026-09-12T07:31:03.87987Z","steps":["trace[311988574] 'process raft request'  (duration: 729.064155ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.880331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.148623Z","time spent":"731.683202ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:27256 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-12T07:31:03.889177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.364201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"}
{"level":"warn","ts":"2026-09-12T07:31:03.88963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.475732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:03.88972Z","caller":"traceutil/trace.go:171","msg":"trace[1052946316] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:27274; }","duration":"108.542023ms","start":"2026-09-12T07:31:03.781127Z","end":"2026-09-12T07:31:03.889669Z","steps":["trace[1052946316] 'agreement among raft nodes before linearized reading'  (duration: 108.437891ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.889996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.245635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-12T07:31:03.890105Z","caller":"traceutil/trace.go:171","msg":"trace[212261223] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27274; }","duration":"275.404249ms","start":"2026-09-12T07:31:03.61468Z","end":"2026-09-12T07:31:03.890084Z","steps":["trace[212261223] 'agreement among raft nodes before linearized reading'  (duration: 275.116503ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:03.890333Z","caller":"traceutil/trace.go:171","msg":"trace[1637089943] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:27274; }","duration":"399.517243ms","start":"2026-09-12T07:31:03.489737Z","end":"2026-09-12T07:31:03.889254Z","steps":["trace[1637089943] 'agreement among raft nodes before linearized reading'  (duration: 399.180246ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:03.890401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.489602Z","time spent":"400.78355ms","remote":"127.0.0.1:59714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1805,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "}
{"level":"info","ts":"2026-09-12T07:31:04.237137Z","caller":"traceutil/trace.go:171","msg":"trace[1907400637] linearizableReadLoop","detail":"{readStateIndex:28191; appliedIndex:28190; }","duration":"285.623896ms","start":"2026-09-12T07:31:03.951485Z","end":"2026-09-12T07:31:04.237109Z","steps":["trace[1907400637] 'read index received'  (duration: 233.287061ms)","trace[1907400637] 'applied index is now lower than readState.Index'  (duration: 52.335295ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:04.23728Z","caller":"traceutil/trace.go:171","msg":"trace[2096971407] transaction","detail":"{read_only:false; response_revision:27275; number_of_response:1; }","duration":"340.507646ms","start":"2026-09-12T07:31:03.896749Z","end":"2026-09-12T07:31:04.237256Z","steps":["trace[2096971407] 'process raft request'  (duration: 288.12972ms)","trace[2096971407] 'compare'  (duration: 51.921577ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:04.237406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:03.896724Z","time spent":"340.586927ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:27259 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-09-12T07:31:04.237614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.105806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:04.237724Z","caller":"traceutil/trace.go:171","msg":"trace[1044869878] 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:27275; }","duration":"286.262999ms","start":"2026-09-12T07:31:03.951432Z","end":"2026-09-12T07:31:04.237695Z","steps":["trace[1044869878] 'agreement among raft nodes before linearized reading'  (duration: 286.119446ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:04.386871Z","caller":"traceutil/trace.go:171","msg":"trace[498460297] linearizableReadLoop","detail":"{readStateIndex:28192; appliedIndex:28191; }","duration":"136.691462ms","start":"2026-09-12T07:31:04.250149Z","end":"2026-09-12T07:31:04.38684Z","steps":["trace[498460297] 'read index received'  (duration: 133.567915ms)","trace[498460297] 'applied index is now lower than readState.Index'  (duration: 3.121357ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:04.387043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.863866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:04.387121Z","caller":"traceutil/trace.go:171","msg":"trace[1579083267] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:27277; }","duration":"136.981578ms","start":"2026-09-12T07:31:04.25012Z","end":"2026-09-12T07:31:04.387101Z","steps":["trace[1579083267] 'agreement among raft nodes before linearized reading'  (duration: 136.828884ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:04.387285Z","caller":"traceutil/trace.go:171","msg":"trace[1793518781] transaction","detail":"{read_only:false; response_revision:27276; number_of_response:1; }","duration":"138.91256ms","start":"2026-09-12T07:31:04.248343Z","end":"2026-09-12T07:31:04.387256Z","steps":["trace[1793518781] 'process raft request'  (duration: 135.175359ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:04.723052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.827396ms","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-09-12T07:31:04.72323Z","caller":"traceutil/trace.go:171","msg":"trace[258001888] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:27277; }","duration":"183.03137ms","start":"2026-09-12T07:31:04.540154Z","end":"2026-09-12T07:31:04.723185Z","steps":["trace[258001888] 'count revisions from in-memory index tree'  (duration: 182.714473ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:05.431258Z","caller":"traceutil/trace.go:171","msg":"trace[322264146] transaction","detail":"{read_only:false; response_revision:27280; number_of_response:1; }","duration":"335.633892ms","start":"2026-09-12T07:31:05.095592Z","end":"2026-09-12T07:31:05.431226Z","steps":["trace[322264146] 'process raft request'  (duration: 329.666505ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:05.431435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:05.095573Z","time spent":"335.778545ms","remote":"127.0.0.1:59826","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:27265 > 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-09-12T07:31:05.431242Z","caller":"traceutil/trace.go:171","msg":"trace[956267575] linearizableReadLoop","detail":"{readStateIndex:28196; appliedIndex:28195; }","duration":"295.761742ms","start":"2026-09-12T07:31:05.135406Z","end":"2026-09-12T07:31:05.431167Z","steps":["trace[956267575] 'read index received'  (duration: 289.875447ms)","trace[956267575] 'applied index is now lower than readState.Index'  (duration: 5.884495ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:05.43153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.108199ms","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-09-12T07:31:05.431596Z","caller":"traceutil/trace.go:171","msg":"trace[781565439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27280; }","duration":"296.225522ms","start":"2026-09-12T07:31:05.135353Z","end":"2026-09-12T07:31:05.431578Z","steps":["trace[781565439] 'agreement among raft nodes before linearized reading'  (duration: 295.987807ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:05.756408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.716815ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728049 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:27269 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:31:05.756637Z","caller":"traceutil/trace.go:171","msg":"trace[2115984548] transaction","detail":"{read_only:false; response_revision:27283; number_of_response:1; }","duration":"284.373288ms","start":"2026-09-12T07:31:05.472242Z","end":"2026-09-12T07:31:05.756615Z","steps":["trace[2115984548] 'process raft request'  (duration: 284.273176ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:05.756664Z","caller":"traceutil/trace.go:171","msg":"trace[771923022] transaction","detail":"{read_only:false; response_revision:27282; number_of_response:1; }","duration":"284.547562ms","start":"2026-09-12T07:31:05.472089Z","end":"2026-09-12T07:31:05.756637Z","steps":["trace[771923022] 'process raft request'  (duration: 107.51608ms)","trace[771923022] 'compare'  (duration: 176.524411ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:06.093727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.4641ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728052 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:27271 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:31:06.09387Z","caller":"traceutil/trace.go:171","msg":"trace[326511699] transaction","detail":"{read_only:false; response_revision:27285; number_of_response:1; }","duration":"208.919792ms","start":"2026-09-12T07:31:05.884924Z","end":"2026-09-12T07:31:06.093843Z","steps":["trace[326511699] 'process raft request'  (duration: 78.239937ms)","trace[326511699] 'compare'  (duration: 130.335658ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:06.120562Z","caller":"traceutil/trace.go:171","msg":"trace[2137135913] linearizableReadLoop","detail":"{readStateIndex:28205; appliedIndex:28200; }","duration":"185.434331ms","start":"2026-09-12T07:31:05.935114Z","end":"2026-09-12T07:31:06.120548Z","steps":["trace[2137135913] 'read index received'  (duration: 28.063268ms)","trace[2137135913] 'applied index is now lower than readState.Index'  (duration: 157.369693ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:06.120563Z","caller":"traceutil/trace.go:171","msg":"trace[1481059151] transaction","detail":"{read_only:false; response_revision:27287; number_of_response:1; }","duration":"235.329724ms","start":"2026-09-12T07:31:05.885203Z","end":"2026-09-12T07:31:06.120533Z","steps":["trace[1481059151] 'process raft request'  (duration: 235.031538ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:06.120683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.558914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:06.120719Z","caller":"traceutil/trace.go:171","msg":"trace[1534017251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27289; }","duration":"185.684677ms","start":"2026-09-12T07:31:05.935025Z","end":"2026-09-12T07:31:06.12071Z","steps":["trace[1534017251] 'agreement among raft nodes before linearized reading'  (duration: 185.589005ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:06.121001Z","caller":"traceutil/trace.go:171","msg":"trace[793045226] transaction","detail":"{read_only:false; response_revision:27288; number_of_response:1; }","duration":"235.424407ms","start":"2026-09-12T07:31:05.885566Z","end":"2026-09-12T07:31:06.12099Z","steps":["trace[793045226] 'process raft request'  (duration: 234.879375ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:06.121118Z","caller":"traceutil/trace.go:171","msg":"trace[2124559147] transaction","detail":"{read_only:false; response_revision:27289; number_of_response:1; }","duration":"224.017122ms","start":"2026-09-12T07:31:05.897092Z","end":"2026-09-12T07:31:06.12111Z","steps":["trace[2124559147] 'process raft request'  (duration: 223.409609ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:06.120356Z","caller":"traceutil/trace.go:171","msg":"trace[839007656] transaction","detail":"{read_only:false; response_revision:27286; number_of_response:1; }","duration":"235.13168ms","start":"2026-09-12T07:31:05.885172Z","end":"2026-09-12T07:31:06.120304Z","steps":["trace[839007656] 'process raft request'  (duration: 234.916416ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:06.575822Z","caller":"traceutil/trace.go:171","msg":"trace[1436936626] linearizableReadLoop","detail":"{readStateIndex:28207; appliedIndex:28206; }","duration":"185.505122ms","start":"2026-09-12T07:31:06.390289Z","end":"2026-09-12T07:31:06.575794Z","steps":["trace[1436936626] 'read index received'  (duration: 185.424821ms)","trace[1436936626] 'applied index is now lower than readState.Index'  (duration: 79.061µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:06.57585Z","caller":"traceutil/trace.go:171","msg":"trace[705284391] transaction","detail":"{read_only:false; response_revision:27291; number_of_response:1; }","duration":"324.848392ms","start":"2026-09-12T07:31:06.250971Z","end":"2026-09-12T07:31:06.575819Z","steps":["trace[705284391] 'process raft request'  (duration: 324.683798ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:06.575978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:06.250939Z","time spent":"324.973605ms","remote":"127.0.0.1:59826","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:27275 > 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-09-12T07:31:06.57603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.720117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-09-12T07:31:06.576094Z","caller":"traceutil/trace.go:171","msg":"trace[157575569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27291; }","duration":"185.863859ms","start":"2026-09-12T07:31:06.390218Z","end":"2026-09-12T07:31:06.576082Z","steps":["trace[157575569] 'agreement among raft nodes before linearized reading'  (duration: 185.696996ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:06.802312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.040507ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728063 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:27277 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:31:06.802416Z","caller":"traceutil/trace.go:171","msg":"trace[888760998] linearizableReadLoop","detail":"{readStateIndex:28208; appliedIndex:28207; }","duration":"226.504867ms","start":"2026-09-12T07:31:06.575893Z","end":"2026-09-12T07:31:06.802397Z","steps":["trace[888760998] 'read index received'  (duration: 106.895638ms)","trace[888760998] 'applied index is now lower than readState.Index'  (duration: 119.607919ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:06.802534Z","caller":"traceutil/trace.go:171","msg":"trace[242813296] transaction","detail":"{read_only:false; response_revision:27292; number_of_response:1; }","duration":"410.121869ms","start":"2026-09-12T07:31:06.392379Z","end":"2026-09-12T07:31:06.802501Z","steps":["trace[242813296] 'process raft request'  (duration: 290.460939ms)","trace[242813296] 'compare'  (duration: 118.437373ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:06.802651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:06.392359Z","time spent":"410.234712ms","remote":"127.0.0.1:59826","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:27277 > 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-09-12T07:31:06.802716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.509168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.58\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-09-12T07:31:06.802755Z","caller":"traceutil/trace.go:171","msg":"trace[185260420] range","detail":"{range_begin:/registry/masterleases/162.253.55.58; range_end:; response_count:1; response_revision:27292; }","duration":"387.60766ms","start":"2026-09-12T07:31:06.415135Z","end":"2026-09-12T07:31:06.802743Z","steps":["trace[185260420] 'agreement among raft nodes before linearized reading'  (duration: 387.362505ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:06.803021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:06.415116Z","time spent":"387.889686ms","remote":"127.0.0.1:59596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/162.253.55.58\" "}
{"level":"warn","ts":"2026-09-12T07:31:06.803035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.182404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:06.803132Z","caller":"traceutil/trace.go:171","msg":"trace[1094983183] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:27292; }","duration":"229.334417ms","start":"2026-09-12T07:31:06.57378Z","end":"2026-09-12T07:31:06.803114Z","steps":["trace[1094983183] 'agreement among raft nodes before linearized reading'  (duration: 229.199614ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:06.817812Z","caller":"traceutil/trace.go:171","msg":"trace[1796111387] transaction","detail":"{read_only:false; response_revision:27293; number_of_response:1; }","duration":"236.573661ms","start":"2026-09-12T07:31:06.581223Z","end":"2026-09-12T07:31:06.817797Z","steps":["trace[1796111387] 'process raft request'  (duration: 236.477489ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:07.165459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.084507ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728073 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:27224 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:31:07.165624Z","caller":"traceutil/trace.go:171","msg":"trace[1534961276] linearizableReadLoop","detail":"{readStateIndex:28212; appliedIndex:28211; }","duration":"243.005847ms","start":"2026-09-12T07:31:06.922595Z","end":"2026-09-12T07:31:07.165601Z","steps":["trace[1534961276] 'read index received'  (duration: 92.663925ms)","trace[1534961276] 'applied index is now lower than readState.Index'  (duration: 150.339872ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:07.165691Z","caller":"traceutil/trace.go:171","msg":"trace[814566766] transaction","detail":"{read_only:false; response_revision:27295; number_of_response:1; }","duration":"293.853401ms","start":"2026-09-12T07:31:06.87178Z","end":"2026-09-12T07:31:07.165633Z","steps":["trace[814566766] 'process raft request'  (duration: 143.494238ms)","trace[814566766] 'compare'  (duration: 149.352482ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:07.165857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.227252ms","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":"info","ts":"2026-09-12T07:31:07.165974Z","caller":"traceutil/trace.go:171","msg":"trace[235296936] 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:27295; }","duration":"243.387976ms","start":"2026-09-12T07:31:06.92255Z","end":"2026-09-12T07:31:07.165938Z","steps":["trace[235296936] 'agreement among raft nodes before linearized reading'  (duration: 243.13319ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:07.220508Z","caller":"traceutil/trace.go:171","msg":"trace[1821647280] transaction","detail":"{read_only:false; response_revision:27296; number_of_response:1; }","duration":"115.574392ms","start":"2026-09-12T07:31:07.104889Z","end":"2026-09-12T07:31:07.220464Z","steps":["trace[1821647280] 'process raft request'  (duration: 115.393238ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:07.716193Z","caller":"traceutil/trace.go:171","msg":"trace[42583936] linearizableReadLoop","detail":"{readStateIndex:28215; appliedIndex:28214; }","duration":"118.109276ms","start":"2026-09-12T07:31:07.598044Z","end":"2026-09-12T07:31:07.716153Z","steps":["trace[42583936] 'read index received'  (duration: 74.871694ms)","trace[42583936] 'applied index is now lower than readState.Index'  (duration: 43.236262ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:07.716238Z","caller":"traceutil/trace.go:171","msg":"trace[2003261429] transaction","detail":"{read_only:false; response_revision:27298; number_of_response:1; }","duration":"178.628866ms","start":"2026-09-12T07:31:07.53758Z","end":"2026-09-12T07:31:07.716209Z","steps":["trace[2003261429] 'process raft request'  (duration: 135.468446ms)","trace[2003261429] 'compare'  (duration: 42.904955ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:07.71648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.408932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-09-12T07:31:07.716538Z","caller":"traceutil/trace.go:171","msg":"trace[699005511] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:27298; }","duration":"118.529875ms","start":"2026-09-12T07:31:07.597993Z","end":"2026-09-12T07:31:07.716523Z","steps":["trace[699005511] 'agreement among raft nodes before linearized reading'  (duration: 118.29274ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:07.879263Z","caller":"traceutil/trace.go:171","msg":"trace[1338976896] transaction","detail":"{read_only:false; response_revision:27299; number_of_response:1; }","duration":"114.670084ms","start":"2026-09-12T07:31:07.76456Z","end":"2026-09-12T07:31:07.87923Z","steps":["trace[1338976896] 'process raft request'  (duration: 112.992958ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:07.879264Z","caller":"traceutil/trace.go:171","msg":"trace[336423235] transaction","detail":"{read_only:false; response_revision:27300; number_of_response:1; }","duration":"114.539651ms","start":"2026-09-12T07:31:07.764687Z","end":"2026-09-12T07:31:07.879227Z","steps":["trace[336423235] 'process raft request'  (duration: 114.255125ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:13.968445Z","caller":"traceutil/trace.go:171","msg":"trace[931822096] transaction","detail":"{read_only:false; response_revision:27339; number_of_response:1; }","duration":"210.191599ms","start":"2026-09-12T07:31:13.758228Z","end":"2026-09-12T07:31:13.968419Z","steps":["trace[931822096] 'process raft request'  (duration: 210.014215ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.530718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9396655706452728172,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-12T07:31:14.596989Z","caller":"traceutil/trace.go:171","msg":"trace[264198403] transaction","detail":"{read_only:false; response_revision:27340; number_of_response:1; }","duration":"623.478974ms","start":"2026-09-12T07:31:13.973479Z","end":"2026-09-12T07:31:14.596958Z","steps":["trace[264198403] 'process raft request'  (duration: 623.301351ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.597172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:13.973459Z","time spent":"623.629578ms","remote":"127.0.0.1:59826","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:27327 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-12T07:31:14.939726Z","caller":"traceutil/trace.go:171","msg":"trace[1401473759] transaction","detail":"{read_only:false; response_revision:27341; number_of_response:1; }","duration":"965.150705ms","start":"2026-09-12T07:31:13.974545Z","end":"2026-09-12T07:31:14.939696Z","steps":["trace[1401473759] 'process raft request'  (duration: 964.90784ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.939898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:13.974529Z","time spent":"965.285158ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:27328 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-12T07:31:14.940101Z","caller":"traceutil/trace.go:171","msg":"trace[2092677167] transaction","detail":"{read_only:false; response_revision:27342; number_of_response:1; }","duration":"816.758314ms","start":"2026-09-12T07:31:14.123286Z","end":"2026-09-12T07:31:14.940045Z","steps":["trace[2092677167] 'process raft request'  (duration: 816.339475ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.940211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.123266Z","time spent":"816.889757ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:27329 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-12T07:31:14.940573Z","caller":"traceutil/trace.go:171","msg":"trace[973735640] transaction","detail":"{read_only:false; response_revision:27345; number_of_response:1; }","duration":"775.120597ms","start":"2026-09-12T07:31:14.16543Z","end":"2026-09-12T07:31:14.94055Z","steps":["trace[973735640] 'process raft request'  (duration: 775.041385ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.941855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.165397Z","time spent":"776.357722ms","remote":"127.0.0.1:59826","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:27333 > 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-09-12T07:31:14.942112Z","caller":"traceutil/trace.go:171","msg":"trace[904922903] transaction","detail":"{read_only:false; response_revision:27344; number_of_response:1; }","duration":"780.878418ms","start":"2026-09-12T07:31:14.161165Z","end":"2026-09-12T07:31:14.942044Z","steps":["trace[904922903] 'process raft request'  (duration: 779.241984ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:14.942122Z","caller":"traceutil/trace.go:171","msg":"trace[775138865] transaction","detail":"{read_only:false; response_revision:27343; number_of_response:1; }","duration":"789.174176ms","start":"2026-09-12T07:31:14.152885Z","end":"2026-09-12T07:31:14.942059Z","steps":["trace[775138865] 'process raft request'  (duration: 787.051601ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.942203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.161148Z","time spent":"781.00035ms","remote":"127.0.0.1:59826","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:27331 > 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-09-12T07:31:14.942326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.152862Z","time spent":"789.378119ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:27330 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-09-12T07:31:14.943274Z","caller":"traceutil/trace.go:171","msg":"trace[155304165] linearizableReadLoop","detail":"{readStateIndex:28264; appliedIndex:28257; }","duration":"912.826681ms","start":"2026-09-12T07:31:14.030377Z","end":"2026-09-12T07:31:14.943203Z","steps":["trace[155304165] 'read index received'  (duration: 566.412299ms)","trace[155304165] 'applied index is now lower than readState.Index'  (duration: 346.412022ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:14.94362Z","caller":"traceutil/trace.go:171","msg":"trace[1737760068] transaction","detail":"{read_only:false; response_revision:27346; number_of_response:1; }","duration":"777.879306ms","start":"2026-09-12T07:31:14.165715Z","end":"2026-09-12T07:31:14.943595Z","steps":["trace[1737760068] 'process raft request'  (duration: 774.80699ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.94373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.165688Z","time spent":"777.978367ms","remote":"127.0.0.1:59826","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:27332 > 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-09-12T07:31:14.944132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.7559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-09-12T07:31:14.944205Z","caller":"traceutil/trace.go:171","msg":"trace[1790872699] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27346; }","duration":"913.857652ms","start":"2026-09-12T07:31:14.030317Z","end":"2026-09-12T07:31:14.944175Z","steps":["trace[1790872699] 'agreement among raft nodes before linearized reading'  (duration: 913.635927ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:14.944273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.030287Z","time spent":"913.974625ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-12T07:31:15.366918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.643401ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452728180 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:27335 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T07:31:15.367044Z","caller":"traceutil/trace.go:171","msg":"trace[1284783459] linearizableReadLoop","detail":"{readStateIndex:28265; appliedIndex:28264; }","duration":"423.698458ms","start":"2026-09-12T07:31:14.943322Z","end":"2026-09-12T07:31:15.36702Z","steps":["trace[1284783459] 'read index received'  (duration: 149.689979ms)","trace[1284783459] 'applied index is now lower than readState.Index'  (duration: 274.006279ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:15.367247Z","caller":"traceutil/trace.go:171","msg":"trace[1013677717] transaction","detail":"{read_only:false; response_revision:27348; number_of_response:1; }","duration":"120.432027ms","start":"2026-09-12T07:31:15.246803Z","end":"2026-09-12T07:31:15.367235Z","steps":["trace[1013677717] 'process raft request'  (duration: 120.365795ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:15.367253Z","caller":"traceutil/trace.go:171","msg":"trace[917443710] transaction","detail":"{read_only:false; response_revision:27347; number_of_response:1; }","duration":"527.223164ms","start":"2026-09-12T07:31:14.839982Z","end":"2026-09-12T07:31:15.367205Z","steps":["trace[917443710] 'process raft request'  (duration: 253.126373ms)","trace[917443710] 'compare'  (duration: 273.515449ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:15.367318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.475423ms","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-09-12T07:31:15.36739Z","caller":"traceutil/trace.go:171","msg":"trace[1674587052] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27347; }","duration":"514.594915ms","start":"2026-09-12T07:31:14.85278Z","end":"2026-09-12T07:31:15.367375Z","steps":["trace[1674587052] 'agreement among raft nodes before linearized reading'  (duration: 514.413862ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.367427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.839957Z","time spent":"527.389828ms","remote":"127.0.0.1:59826","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:27335 > 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-09-12T07:31:15.36745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.625445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-09-12T07:31:15.367475Z","caller":"traceutil/trace.go:171","msg":"trace[108771948] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27348; }","duration":"414.683556ms","start":"2026-09-12T07:31:14.952785Z","end":"2026-09-12T07:31:15.367469Z","steps":["trace[108771948] 'agreement among raft nodes before linearized reading'  (duration: 414.617715ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.367495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.952766Z","time spent":"414.724477ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-12T07:31:15.367435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.852754Z","time spent":"514.668677ms","remote":"127.0.0.1:59826","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-09-12T07:31:15.367564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.885769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-12T07:31:15.367613Z","caller":"traceutil/trace.go:171","msg":"trace[1579761673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27348; }","duration":"742.975611ms","start":"2026-09-12T07:31:14.624625Z","end":"2026-09-12T07:31:15.3676Z","steps":["trace[1579761673] 'agreement among raft nodes before linearized reading'  (duration: 742.854109ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.367676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.624604Z","time spent":"743.060733ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-12T07:31:15.367256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.877602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:15.367896Z","caller":"traceutil/trace.go:171","msg":"trace[540338671] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:27347; }","duration":"455.529996ms","start":"2026-09-12T07:31:14.912302Z","end":"2026-09-12T07:31:15.367832Z","steps":["trace[540338671] 'agreement among raft nodes before linearized reading'  (duration: 454.844842ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.367946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.912284Z","time spent":"455.648438ms","remote":"127.0.0.1:43252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "}
{"level":"warn","ts":"2026-09-12T07:31:15.367592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.152713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:15.36833Z","caller":"traceutil/trace.go:171","msg":"trace[257465735] 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:27348; }","duration":"956.94868ms","start":"2026-09-12T07:31:14.411358Z","end":"2026-09-12T07:31:15.368307Z","steps":["trace[257465735] 'agreement among raft nodes before linearized reading'  (duration: 955.97634ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.36843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:14.411338Z","time spent":"957.075252ms","remote":"127.0.0.1:33912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"info","ts":"2026-09-12T07:31:15.81878Z","caller":"traceutil/trace.go:171","msg":"trace[2070407599] transaction","detail":"{read_only:false; response_revision:27350; number_of_response:1; }","duration":"444.816138ms","start":"2026-09-12T07:31:15.373928Z","end":"2026-09-12T07:31:15.818744Z","steps":["trace[2070407599] 'process raft request'  (duration: 422.756428ms)","trace[2070407599] 'compare'  (duration: 21.205562ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:15.818754Z","caller":"traceutil/trace.go:171","msg":"trace[193950226] linearizableReadLoop","detail":"{readStateIndex:28268; appliedIndex:28266; }","duration":"443.589342ms","start":"2026-09-12T07:31:15.375086Z","end":"2026-09-12T07:31:15.818675Z","steps":["trace[193950226] 'read index received'  (duration: 7.854188ms)","trace[193950226] 'applied index is now lower than readState.Index'  (duration: 435.731254ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:15.818912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.814596ms","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-09-12T07:31:15.819Z","caller":"traceutil/trace.go:171","msg":"trace[735029610] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:27350; }","duration":"443.950979ms","start":"2026-09-12T07:31:15.375027Z","end":"2026-09-12T07:31:15.818978Z","steps":["trace[735029610] 'agreement among raft nodes before linearized reading'  (duration: 443.761125ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.819053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:15.375015Z","time spent":"444.023ms","remote":"127.0.0.1:59744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-09-12T07:31:15.819652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:15.373903Z","time spent":"444.980392ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:27334 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-09-12T07:31:15.827048Z","caller":"traceutil/trace.go:171","msg":"trace[960914412] transaction","detail":"{read_only:false; response_revision:27351; number_of_response:1; }","duration":"261.141495ms","start":"2026-09-12T07:31:15.565876Z","end":"2026-09-12T07:31:15.827018Z","steps":["trace[960914412] 'process raft request'  (duration: 260.995182ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.82712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.853482ms","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-09-12T07:31:15.827175Z","caller":"traceutil/trace.go:171","msg":"trace[569436126] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:27351; }","duration":"263.957205ms","start":"2026-09-12T07:31:15.563202Z","end":"2026-09-12T07:31:15.827159Z","steps":["trace[569436126] 'agreement among raft nodes before linearized reading'  (duration: 263.809422ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.827304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.676314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:15.827367Z","caller":"traceutil/trace.go:171","msg":"trace[304540802] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:27351; }","duration":"443.786866ms","start":"2026-09-12T07:31:15.383567Z","end":"2026-09-12T07:31:15.827354Z","steps":["trace[304540802] 'agreement among raft nodes before linearized reading'  (duration: 443.678513ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.827401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:15.383551Z","time spent":"443.839537ms","remote":"127.0.0.1:59780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-09-12T07:31:15.827429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.436456ms","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-09-12T07:31:15.827477Z","caller":"traceutil/trace.go:171","msg":"trace[642857717] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27351; }","duration":"388.523278ms","start":"2026-09-12T07:31:15.438938Z","end":"2026-09-12T07:31:15.827461Z","steps":["trace[642857717] 'agreement among raft nodes before linearized reading'  (duration: 388.443496ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:15.827506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:31:15.438915Z","time spent":"388.583829ms","remote":"127.0.0.1:60000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-09-12T07:31:22.291801Z","caller":"traceutil/trace.go:171","msg":"trace[448288509] linearizableReadLoop","detail":"{readStateIndex:28382; appliedIndex:28381; }","duration":"136.108811ms","start":"2026-09-12T07:31:22.155656Z","end":"2026-09-12T07:31:22.291765Z","steps":["trace[448288509] 'read index received'  (duration: 64.335001ms)","trace[448288509] 'applied index is now lower than readState.Index'  (duration: 71.77175ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:22.291958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.282034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:22.291996Z","caller":"traceutil/trace.go:171","msg":"trace[386176173] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:27461; }","duration":"136.396316ms","start":"2026-09-12T07:31:22.155587Z","end":"2026-09-12T07:31:22.291983Z","steps":["trace[386176173] 'agreement among raft nodes before linearized reading'  (duration: 136.281754ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:22.767933Z","caller":"traceutil/trace.go:171","msg":"trace[1340894619] linearizableReadLoop","detail":"{readStateIndex:28383; appliedIndex:28382; }","duration":"108.085343ms","start":"2026-09-12T07:31:22.659814Z","end":"2026-09-12T07:31:22.767899Z","steps":["trace[1340894619] 'read index received'  (duration: 62.081µs)","trace[1340894619] 'applied index is now lower than readState.Index'  (duration: 108.021942ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:22.768336Z","caller":"traceutil/trace.go:171","msg":"trace[684424808] transaction","detail":"{read_only:false; response_revision:27462; number_of_response:1; }","duration":"108.565833ms","start":"2026-09-12T07:31:22.659753Z","end":"2026-09-12T07:31:22.768318Z","steps":["trace[684424808] 'process raft request'  (duration: 107.95235ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:22.768657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.829929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"}
{"level":"info","ts":"2026-09-12T07:31:22.768705Z","caller":"traceutil/trace.go:171","msg":"trace[248640009] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:27462; }","duration":"108.917261ms","start":"2026-09-12T07:31:22.659775Z","end":"2026-09-12T07:31:22.768692Z","steps":["trace[248640009] 'agreement among raft nodes before linearized reading'  (duration: 108.757928ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:22.963839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.818904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"}
{"level":"info","ts":"2026-09-12T07:31:22.963942Z","caller":"traceutil/trace.go:171","msg":"trace[1925159539] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:27462; }","duration":"180.927586ms","start":"2026-09-12T07:31:22.782977Z","end":"2026-09-12T07:31:22.963904Z","steps":["trace[1925159539] 'range keys from in-memory index tree'  (duration: 180.565398ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.09943Z","caller":"traceutil/trace.go:171","msg":"trace[1060133288] transaction","detail":"{read_only:false; response_revision:27465; number_of_response:1; }","duration":"127.758282ms","start":"2026-09-12T07:31:22.971635Z","end":"2026-09-12T07:31:23.099393Z","steps":["trace[1060133288] 'process raft request'  (duration: 127.66111ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.099449Z","caller":"traceutil/trace.go:171","msg":"trace[1814113819] transaction","detail":"{read_only:false; response_revision:27464; number_of_response:1; }","duration":"127.844653ms","start":"2026-09-12T07:31:22.971566Z","end":"2026-09-12T07:31:23.099411Z","steps":["trace[1814113819] 'process raft request'  (duration: 127.099077ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.099687Z","caller":"traceutil/trace.go:171","msg":"trace[1178947938] transaction","detail":"{read_only:false; response_revision:27466; number_of_response:1; }","duration":"126.939114ms","start":"2026-09-12T07:31:22.972715Z","end":"2026-09-12T07:31:23.099654Z","steps":["trace[1178947938] 'process raft request'  (duration: 126.653498ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.099877Z","caller":"traceutil/trace.go:171","msg":"trace[781391056] transaction","detail":"{read_only:false; response_revision:27467; number_of_response:1; }","duration":"124.497952ms","start":"2026-09-12T07:31:22.97535Z","end":"2026-09-12T07:31:23.099848Z","steps":["trace[781391056] 'process raft request'  (duration: 124.235887ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.100032Z","caller":"traceutil/trace.go:171","msg":"trace[1605351803] linearizableReadLoop","detail":"{readStateIndex:28387; appliedIndex:28383; }","duration":"125.567185ms","start":"2026-09-12T07:31:22.974424Z","end":"2026-09-12T07:31:23.099991Z","steps":["trace[1605351803] 'read index received'  (duration: 24.40834ms)","trace[1605351803] 'applied index is now lower than readState.Index'  (duration: 101.156625ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:23.100146Z","caller":"traceutil/trace.go:171","msg":"trace[2102492942] transaction","detail":"{read_only:false; response_revision:27468; number_of_response:1; }","duration":"120.558279ms","start":"2026-09-12T07:31:22.979509Z","end":"2026-09-12T07:31:23.100067Z","steps":["trace[2102492942] 'process raft request'  (duration: 120.263273ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:23.100362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.901704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-09-12T07:31:23.10037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.923373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18d4825b512c097d\" ","response":"range_response_count:1 size:742"}
{"level":"warn","ts":"2026-09-12T07:31:23.100411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.74251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1446"}
{"level":"info","ts":"2026-09-12T07:31:23.100437Z","caller":"traceutil/trace.go:171","msg":"trace[1192562702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27468; }","duration":"119.005686ms","start":"2026-09-12T07:31:22.981414Z","end":"2026-09-12T07:31:23.10042Z","steps":["trace[1192562702] 'agreement among raft nodes before linearized reading'  (duration: 118.801531ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.100467Z","caller":"traceutil/trace.go:171","msg":"trace[322625855] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:27468; }","duration":"125.855322ms","start":"2026-09-12T07:31:22.974599Z","end":"2026-09-12T07:31:23.100454Z","steps":["trace[322625855] 'agreement among raft nodes before linearized reading'  (duration: 125.612436ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:23.100475Z","caller":"traceutil/trace.go:171","msg":"trace[966363033] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18d4825b512c097d; range_end:; response_count:1; response_revision:27468; }","duration":"126.096937ms","start":"2026-09-12T07:31:22.974353Z","end":"2026-09-12T07:31:23.100449Z","steps":["trace[966363033] 'agreement among raft nodes before linearized reading'  (duration: 125.780099ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:25.234613Z","caller":"traceutil/trace.go:171","msg":"trace[1313953258] transaction","detail":"{read_only:false; response_revision:27482; number_of_response:1; }","duration":"125.880772ms","start":"2026-09-12T07:31:25.108699Z","end":"2026-09-12T07:31:25.234579Z","steps":["trace[1313953258] 'process raft request'  (duration: 125.674038ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:25.389761Z","caller":"traceutil/trace.go:171","msg":"trace[705401438] transaction","detail":"{read_only:false; response_revision:27483; number_of_response:1; }","duration":"280.707941ms","start":"2026-09-12T07:31:25.109027Z","end":"2026-09-12T07:31:25.389735Z","steps":["trace[705401438] 'process raft request'  (duration: 219.17945ms)","trace[705401438] 'compare'  (duration: 61.379368ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:25.390168Z","caller":"traceutil/trace.go:171","msg":"trace[1607145716] transaction","detail":"{read_only:false; response_revision:27484; number_of_response:1; }","duration":"280.68314ms","start":"2026-09-12T07:31:25.109448Z","end":"2026-09-12T07:31:25.390132Z","steps":["trace[1607145716] 'process raft request'  (duration: 280.254351ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:25.390267Z","caller":"traceutil/trace.go:171","msg":"trace[1877618125] transaction","detail":"{read_only:false; response_revision:27485; number_of_response:1; }","duration":"280.789423ms","start":"2026-09-12T07:31:25.109469Z","end":"2026-09-12T07:31:25.390259Z","steps":["trace[1877618125] 'process raft request'  (duration: 280.471006ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:25.390368Z","caller":"traceutil/trace.go:171","msg":"trace[2122599622] linearizableReadLoop","detail":"{readStateIndex:28406; appliedIndex:28402; }","duration":"276.248707ms","start":"2026-09-12T07:31:25.11411Z","end":"2026-09-12T07:31:25.390359Z","steps":["trace[2122599622] 'read index received'  (duration: 120.164411ms)","trace[2122599622] 'applied index is now lower than readState.Index'  (duration: 156.083566ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:25.390193Z","caller":"traceutil/trace.go:171","msg":"trace[1625667057] transaction","detail":"{read_only:false; response_revision:27486; number_of_response:1; }","duration":"149.25999ms","start":"2026-09-12T07:31:25.240898Z","end":"2026-09-12T07:31:25.390158Z","steps":["trace[1625667057] 'process raft request'  (duration: 149.182298ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:25.390509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.418201ms","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-09-12T07:31:25.390528Z","caller":"traceutil/trace.go:171","msg":"trace[1839158024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27486; }","duration":"276.451811ms","start":"2026-09-12T07:31:25.114071Z","end":"2026-09-12T07:31:25.390523Z","steps":["trace[1839158024] 'agreement among raft nodes before linearized reading'  (duration: 276.353249ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:25.390606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.377572ms","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-09-12T07:31:25.390622Z","caller":"traceutil/trace.go:171","msg":"trace[1420179676] 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:27486; }","duration":"209.450113ms","start":"2026-09-12T07:31:25.181164Z","end":"2026-09-12T07:31:25.390615Z","steps":["trace[1420179676] 'agreement among raft nodes before linearized reading'  (duration: 209.417683ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:25.390644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.91823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T07:31:25.390678Z","caller":"traceutil/trace.go:171","msg":"trace[2073591829] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:27486; }","duration":"253.972901ms","start":"2026-09-12T07:31:25.136695Z","end":"2026-09-12T07:31:25.390668Z","steps":["trace[2073591829] 'agreement among raft nodes before linearized reading'  (duration: 253.820708ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:29.146005Z","caller":"traceutil/trace.go:171","msg":"trace[1529082917] transaction","detail":"{read_only:false; response_revision:27527; number_of_response:1; }","duration":"126.161158ms","start":"2026-09-12T07:31:29.019806Z","end":"2026-09-12T07:31:29.145967Z","steps":["trace[1529082917] 'process raft request'  (duration: 58.277911ms)","trace[1529082917] 'compare'  (duration: 67.736604ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:36.085421Z","caller":"traceutil/trace.go:171","msg":"trace[34482107] linearizableReadLoop","detail":"{readStateIndex:28515; appliedIndex:28514; }","duration":"155.682728ms","start":"2026-09-12T07:31:35.929704Z","end":"2026-09-12T07:31:36.085387Z","steps":["trace[34482107] 'read index received'  (duration: 155.628387ms)","trace[34482107] 'applied index is now lower than readState.Index'  (duration: 52.931µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:36.085663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.925573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-12T07:31:36.085738Z","caller":"traceutil/trace.go:171","msg":"trace[41725494] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27591; }","duration":"156.047326ms","start":"2026-09-12T07:31:35.929677Z","end":"2026-09-12T07:31:36.085724Z","steps":["trace[41725494] 'agreement among raft nodes before linearized reading'  (duration: 155.842422ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:36.085842Z","caller":"traceutil/trace.go:171","msg":"trace[1582865553] transaction","detail":"{read_only:false; response_revision:27591; number_of_response:1; }","duration":"187.299282ms","start":"2026-09-12T07:31:35.898507Z","end":"2026-09-12T07:31:36.085806Z","steps":["trace[1582865553] 'process raft request'  (duration: 186.702139ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:36.144597Z","caller":"traceutil/trace.go:171","msg":"trace[456549787] transaction","detail":"{read_only:false; response_revision:27592; number_of_response:1; }","duration":"129.048259ms","start":"2026-09-12T07:31:36.015515Z","end":"2026-09-12T07:31:36.144564Z","steps":["trace[456549787] 'process raft request'  (duration: 128.865596ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:36.27848Z","caller":"traceutil/trace.go:171","msg":"trace[864124888] linearizableReadLoop","detail":"{readStateIndex:28517; appliedIndex:28515; }","duration":"178.138736ms","start":"2026-09-12T07:31:36.100316Z","end":"2026-09-12T07:31:36.278455Z","steps":["trace[864124888] 'read index received'  (duration: 42.74651ms)","trace[864124888] 'applied index is now lower than readState.Index'  (duration: 135.391156ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:36.278731Z","caller":"traceutil/trace.go:171","msg":"trace[2045438761] transaction","detail":"{read_only:false; response_revision:27593; number_of_response:1; }","duration":"187.679399ms","start":"2026-09-12T07:31:36.091035Z","end":"2026-09-12T07:31:36.278714Z","steps":["trace[2045438761] 'process raft request'  (duration: 87.641187ms)","trace[2045438761] 'compare'  (duration: 99.687415ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:36.279042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.710239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-09-12T07:31:36.279137Z","caller":"traceutil/trace.go:171","msg":"trace[1755669360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27593; }","duration":"178.852191ms","start":"2026-09-12T07:31:36.100272Z","end":"2026-09-12T07:31:36.279124Z","steps":["trace[1755669360] 'agreement among raft nodes before linearized reading'  (duration: 178.647126ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:36.425205Z","caller":"traceutil/trace.go:171","msg":"trace[1448311375] linearizableReadLoop","detail":"{readStateIndex:28518; appliedIndex:28517; }","duration":"140.086445ms","start":"2026-09-12T07:31:36.285079Z","end":"2026-09-12T07:31:36.425165Z","steps":["trace[1448311375] 'read index received'  (duration: 114.572972ms)","trace[1448311375] 'applied index is now lower than readState.Index'  (duration: 25.511973ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:36.425326Z","caller":"traceutil/trace.go:171","msg":"trace[646508411] transaction","detail":"{read_only:false; response_revision:27594; number_of_response:1; }","duration":"141.528105ms","start":"2026-09-12T07:31:36.283758Z","end":"2026-09-12T07:31:36.425286Z","steps":["trace[646508411] 'process raft request'  (duration: 115.980601ms)","trace[646508411] 'compare'  (duration: 25.045473ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:36.425748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.385452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19026"}
{"level":"info","ts":"2026-09-12T07:31:36.425816Z","caller":"traceutil/trace.go:171","msg":"trace[1199298421] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27594; }","duration":"140.743789ms","start":"2026-09-12T07:31:36.285057Z","end":"2026-09-12T07:31:36.425801Z","steps":["trace[1199298421] 'agreement among raft nodes before linearized reading'  (duration: 140.277449ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:38.245461Z","caller":"traceutil/trace.go:171","msg":"trace[263107954] linearizableReadLoop","detail":"{readStateIndex:28533; appliedIndex:28532; }","duration":"109.031783ms","start":"2026-09-12T07:31:38.136389Z","end":"2026-09-12T07:31:38.245421Z","steps":["trace[263107954] 'read index received'  (duration: 106.692993ms)","trace[263107954] 'applied index is now lower than readState.Index'  (duration: 2.3369ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:38.24559Z","caller":"traceutil/trace.go:171","msg":"trace[1825743491] transaction","detail":"{read_only:false; response_revision:27608; number_of_response:1; }","duration":"152.131382ms","start":"2026-09-12T07:31:38.093412Z","end":"2026-09-12T07:31:38.245543Z","steps":["trace[1825743491] 'process raft request'  (duration: 149.624828ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:38.245839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.406762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"}
{"level":"info","ts":"2026-09-12T07:31:38.245895Z","caller":"traceutil/trace.go:171","msg":"trace[1785591229] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:27608; }","duration":"109.538294ms","start":"2026-09-12T07:31:38.136341Z","end":"2026-09-12T07:31:38.24588Z","steps":["trace[1785591229] 'agreement among raft nodes before linearized reading'  (duration: 109.259638ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.640642Z","caller":"traceutil/trace.go:171","msg":"trace[1521146721] transaction","detail":"{read_only:false; response_revision:27734; number_of_response:1; }","duration":"141.829642ms","start":"2026-09-12T07:31:53.498782Z","end":"2026-09-12T07:31:53.640611Z","steps":["trace[1521146721] 'process raft request'  (duration: 102.064855ms)","trace[1521146721] 'compare'  (duration: 39.630054ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:53.692401Z","caller":"traceutil/trace.go:171","msg":"trace[1789093134] transaction","detail":"{read_only:false; response_revision:27735; number_of_response:1; }","duration":"191.996652ms","start":"2026-09-12T07:31:53.500362Z","end":"2026-09-12T07:31:53.692358Z","steps":["trace[1789093134] 'process raft request'  (duration: 191.800638ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.692506Z","caller":"traceutil/trace.go:171","msg":"trace[732450131] transaction","detail":"{read_only:false; response_revision:27738; number_of_response:1; }","duration":"178.405862ms","start":"2026-09-12T07:31:53.514086Z","end":"2026-09-12T07:31:53.692492Z","steps":["trace[732450131] 'process raft request'  (duration: 178.294109ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.692515Z","caller":"traceutil/trace.go:171","msg":"trace[522733070] transaction","detail":"{read_only:false; response_revision:27737; number_of_response:1; }","duration":"187.188379ms","start":"2026-09-12T07:31:53.505285Z","end":"2026-09-12T07:31:53.692473Z","steps":["trace[522733070] 'process raft request'  (duration: 187.053777ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.6926Z","caller":"traceutil/trace.go:171","msg":"trace[801938377] transaction","detail":"{read_only:false; response_revision:27736; number_of_response:1; }","duration":"190.984049ms","start":"2026-09-12T07:31:53.501534Z","end":"2026-09-12T07:31:53.692518Z","steps":["trace[801938377] 'process raft request'  (duration: 190.749514ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.692433Z","caller":"traceutil/trace.go:171","msg":"trace[836777884] linearizableReadLoop","detail":"{readStateIndex:28665; appliedIndex:28661; }","duration":"182.08749ms","start":"2026-09-12T07:31:53.510321Z","end":"2026-09-12T07:31:53.692409Z","steps":["trace[836777884] 'read index received'  (duration: 90.662031ms)","trace[836777884] 'applied index is now lower than readState.Index'  (duration: 91.424149ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:53.692785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.435887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T07:31:53.692888Z","caller":"traceutil/trace.go:171","msg":"trace[1088699730] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:27738; }","duration":"182.600341ms","start":"2026-09-12T07:31:53.510267Z","end":"2026-09-12T07:31:53.692867Z","steps":["trace[1088699730] 'agreement among raft nodes before linearized reading'  (duration: 182.369766ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:53.692878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.154418ms","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-09-12T07:31:53.692931Z","caller":"traceutil/trace.go:171","msg":"trace[1902330016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27738; }","duration":"157.254721ms","start":"2026-09-12T07:31:53.535667Z","end":"2026-09-12T07:31:53.692921Z","steps":["trace[1902330016] 'agreement among raft nodes before linearized reading'  (duration: 157.082187ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:53.692826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.653633ms","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-09-12T07:31:53.692997Z","caller":"traceutil/trace.go:171","msg":"trace[2059879865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27738; }","duration":"107.894008ms","start":"2026-09-12T07:31:53.585093Z","end":"2026-09-12T07:31:53.692987Z","steps":["trace[2059879865] 'agreement among raft nodes before linearized reading'  (duration: 107.657933ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.954686Z","caller":"traceutil/trace.go:171","msg":"trace[893876861] linearizableReadLoop","detail":"{readStateIndex:28668; appliedIndex:28666; }","duration":"204.849175ms","start":"2026-09-12T07:31:53.749811Z","end":"2026-09-12T07:31:53.95466Z","steps":["trace[893876861] 'read index received'  (duration: 119.989066ms)","trace[893876861] 'applied index is now lower than readState.Index'  (duration: 84.858679ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:53.954853Z","caller":"traceutil/trace.go:171","msg":"trace[602103096] transaction","detail":"{read_only:false; response_revision:27740; number_of_response:1; }","duration":"255.239838ms","start":"2026-09-12T07:31:53.699601Z","end":"2026-09-12T07:31:53.954841Z","steps":["trace[602103096] 'process raft request'  (duration: 255.015164ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.954853Z","caller":"traceutil/trace.go:171","msg":"trace[2144797471] transaction","detail":"{read_only:false; response_revision:27739; number_of_response:1; }","duration":"258.127941ms","start":"2026-09-12T07:31:53.696666Z","end":"2026-09-12T07:31:53.954794Z","steps":["trace[2144797471] 'process raft request'  (duration: 173.122759ms)","trace[2144797471] 'compare'  (duration: 84.704075ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:53.955308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.638391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T07:31:53.955309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.467199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:31:53.955369Z","caller":"traceutil/trace.go:171","msg":"trace[2078184268] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:27740; }","duration":"128.746443ms","start":"2026-09-12T07:31:53.826605Z","end":"2026-09-12T07:31:53.955352Z","steps":["trace[2078184268] 'agreement among raft nodes before linearized reading'  (duration: 128.60982ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:53.95538Z","caller":"traceutil/trace.go:171","msg":"trace[837234225] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:27740; }","duration":"205.587881ms","start":"2026-09-12T07:31:53.749773Z","end":"2026-09-12T07:31:53.955361Z","steps":["trace[837234225] 'agreement among raft nodes before linearized reading'  (duration: 205.432958ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:54.644733Z","caller":"traceutil/trace.go:171","msg":"trace[1415857107] linearizableReadLoop","detail":"{readStateIndex:28670; appliedIndex:28669; }","duration":"120.480308ms","start":"2026-09-12T07:31:54.524223Z","end":"2026-09-12T07:31:54.644703Z","steps":["trace[1415857107] 'read index received'  (duration: 120.262433ms)","trace[1415857107] 'applied index is now lower than readState.Index'  (duration: 216.955µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:31:54.644982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.745173ms","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-09-12T07:31:54.645026Z","caller":"traceutil/trace.go:171","msg":"trace[109704629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27742; }","duration":"120.838484ms","start":"2026-09-12T07:31:54.524178Z","end":"2026-09-12T07:31:54.645017Z","steps":["trace[109704629] 'agreement among raft nodes before linearized reading'  (duration: 120.63426ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:54.645364Z","caller":"traceutil/trace.go:171","msg":"trace[834191395] transaction","detail":"{read_only:false; response_revision:27742; number_of_response:1; }","duration":"187.902994ms","start":"2026-09-12T07:31:54.45745Z","end":"2026-09-12T07:31:54.645353Z","steps":["trace[834191395] 'process raft request'  (duration: 187.098507ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:55.384672Z","caller":"traceutil/trace.go:171","msg":"trace[1002196015] linearizableReadLoop","detail":"{readStateIndex:28672; appliedIndex:28671; }","duration":"104.448235ms","start":"2026-09-12T07:31:55.280195Z","end":"2026-09-12T07:31:55.384643Z","steps":["trace[1002196015] 'read index received'  (duration: 104.18529ms)","trace[1002196015] 'applied index is now lower than readState.Index'  (duration: 261.645µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:31:55.384742Z","caller":"traceutil/trace.go:171","msg":"trace[730020633] transaction","detail":"{read_only:false; response_revision:27744; number_of_response:1; }","duration":"104.945766ms","start":"2026-09-12T07:31:55.279763Z","end":"2026-09-12T07:31:55.384709Z","steps":["trace[730020633] 'process raft request'  (duration: 104.712881ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:31:55.385445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.822053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-09-12T07:31:55.385556Z","caller":"traceutil/trace.go:171","msg":"trace[488326575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27744; }","duration":"105.423646ms","start":"2026-09-12T07:31:55.280108Z","end":"2026-09-12T07:31:55.385531Z","steps":["trace[488326575] 'agreement among raft nodes before linearized reading'  (duration: 104.64899ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:31:56.593044Z","caller":"traceutil/trace.go:171","msg":"trace[1248939885] transaction","detail":"{read_only:false; response_revision:27757; number_of_response:1; }","duration":"108.328098ms","start":"2026-09-12T07:31:56.484678Z","end":"2026-09-12T07:31:56.593006Z","steps":["trace[1248939885] 'process raft request'  (duration: 94.898533ms)","trace[1248939885] 'compare'  (duration: 13.165129ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:07.852477Z","caller":"traceutil/trace.go:171","msg":"trace[1881243651] transaction","detail":"{read_only:false; response_revision:27838; number_of_response:1; }","duration":"160.051221ms","start":"2026-09-12T07:32:07.692397Z","end":"2026-09-12T07:32:07.852448Z","steps":["trace[1881243651] 'process raft request'  (duration: 159.887127ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:07.892333Z","caller":"traceutil/trace.go:171","msg":"trace[1579120216] transaction","detail":"{read_only:false; response_revision:27842; number_of_response:1; }","duration":"147.184287ms","start":"2026-09-12T07:32:07.745117Z","end":"2026-09-12T07:32:07.892301Z","steps":["trace[1579120216] 'process raft request'  (duration: 147.142456ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:07.892596Z","caller":"traceutil/trace.go:171","msg":"trace[1730524888] transaction","detail":"{read_only:false; response_revision:27841; number_of_response:1; }","duration":"149.812913ms","start":"2026-09-12T07:32:07.742768Z","end":"2026-09-12T07:32:07.892581Z","steps":["trace[1730524888] 'process raft request'  (duration: 149.453395ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:07.892345Z","caller":"traceutil/trace.go:171","msg":"trace[569644325] transaction","detail":"{read_only:false; response_revision:27839; number_of_response:1; }","duration":"154.502902ms","start":"2026-09-12T07:32:07.737794Z","end":"2026-09-12T07:32:07.892297Z","steps":["trace[569644325] 'process raft request'  (duration: 154.230976ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:07.892827Z","caller":"traceutil/trace.go:171","msg":"trace[591718673] transaction","detail":"{read_only:false; response_revision:27840; number_of_response:1; }","duration":"151.396116ms","start":"2026-09-12T07:32:07.741401Z","end":"2026-09-12T07:32:07.892797Z","steps":["trace[591718673] 'process raft request'  (duration: 150.784193ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:08.21137Z","caller":"traceutil/trace.go:171","msg":"trace[1237674754] transaction","detail":"{read_only:false; response_revision:27843; number_of_response:1; }","duration":"179.531525ms","start":"2026-09-12T07:32:08.031807Z","end":"2026-09-12T07:32:08.211338Z","steps":["trace[1237674754] 'process raft request'  (duration: 179.319841ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:08.341692Z","caller":"traceutil/trace.go:171","msg":"trace[1093808262] transaction","detail":"{read_only:false; response_revision:27844; number_of_response:1; }","duration":"307.732237ms","start":"2026-09-12T07:32:08.033898Z","end":"2026-09-12T07:32:08.34163Z","steps":["trace[1093808262] 'process raft request'  (duration: 295.774922ms)","trace[1093808262] 'compare'  (duration: 11.566437ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:32:08.341882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:08.033875Z","time spent":"307.912841ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:27828 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-12T07:32:08.342081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.70236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11787"}
{"level":"info","ts":"2026-09-12T07:32:08.342295Z","caller":"traceutil/trace.go:171","msg":"trace[2110448598] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:27844; }","duration":"149.964095ms","start":"2026-09-12T07:32:08.192313Z","end":"2026-09-12T07:32:08.342277Z","steps":["trace[2110448598] 'agreement among raft nodes before linearized reading'  (duration: 149.630208ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:08.341903Z","caller":"traceutil/trace.go:171","msg":"trace[203162129] linearizableReadLoop","detail":"{readStateIndex:28775; appliedIndex:28773; }","duration":"149.176749ms","start":"2026-09-12T07:32:08.192367Z","end":"2026-09-12T07:32:08.341543Z","steps":["trace[203162129] 'read index received'  (duration: 18.790831ms)","trace[203162129] 'applied index is now lower than readState.Index'  (duration: 130.384158ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:08.647608Z","caller":"traceutil/trace.go:171","msg":"trace[1720061835] transaction","detail":"{read_only:false; response_revision:27845; number_of_response:1; }","duration":"106.221892ms","start":"2026-09-12T07:32:08.541326Z","end":"2026-09-12T07:32:08.647548Z","steps":["trace[1720061835] 'process raft request'  (duration: 53.191003ms)","trace[1720061835] 'compare'  (duration: 52.873296ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:08.862411Z","caller":"traceutil/trace.go:171","msg":"trace[1499010126] transaction","detail":"{read_only:false; response_revision:27847; number_of_response:1; }","duration":"146.841758ms","start":"2026-09-12T07:32:08.715537Z","end":"2026-09-12T07:32:08.862378Z","steps":["trace[1499010126] 'process raft request'  (duration: 66.349253ms)","trace[1499010126] 'compare'  (duration: 79.878072ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:19.137063Z","caller":"traceutil/trace.go:171","msg":"trace[1400712197] linearizableReadLoop","detail":"{readStateIndex:28860; appliedIndex:28859; }","duration":"191.253205ms","start":"2026-09-12T07:32:18.945777Z","end":"2026-09-12T07:32:19.137031Z","steps":["trace[1400712197] 'read index received'  (duration: 191.01511ms)","trace[1400712197] 'applied index is now lower than readState.Index'  (duration: 236.844µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:19.137216Z","caller":"traceutil/trace.go:171","msg":"trace[2123989284] transaction","detail":"{read_only:false; response_revision:27927; number_of_response:1; }","duration":"323.609566ms","start":"2026-09-12T07:32:18.813596Z","end":"2026-09-12T07:32:19.137205Z","steps":["trace[2123989284] 'process raft request'  (duration: 323.280379ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:19.137346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:18.813564Z","time spent":"323.677897ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:27846 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-09-12T07:32:19.137514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.708144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:32:19.137577Z","caller":"traceutil/trace.go:171","msg":"trace[703583692] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:27927; }","duration":"191.827697ms","start":"2026-09-12T07:32:18.945732Z","end":"2026-09-12T07:32:19.137559Z","steps":["trace[703583692] 'agreement among raft nodes before linearized reading'  (duration: 191.702754ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:19.137727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.187645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-09-12T07:32:19.137768Z","caller":"traceutil/trace.go:171","msg":"trace[789586125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27927; }","duration":"123.287717ms","start":"2026-09-12T07:32:19.014468Z","end":"2026-09-12T07:32:19.137755Z","steps":["trace[789586125] 'agreement among raft nodes before linearized reading'  (duration: 123.127603ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:19.137939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.353537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-12T07:32:19.138099Z","caller":"traceutil/trace.go:171","msg":"trace[1595769738] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27927; }","duration":"191.585512ms","start":"2026-09-12T07:32:18.946476Z","end":"2026-09-12T07:32:19.138062Z","steps":["trace[1595769738] 'agreement among raft nodes before linearized reading'  (duration: 191.02947ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:19.282539Z","caller":"traceutil/trace.go:171","msg":"trace[802469835] transaction","detail":"{read_only:false; response_revision:27928; number_of_response:1; }","duration":"139.597855ms","start":"2026-09-12T07:32:19.142867Z","end":"2026-09-12T07:32:19.282465Z","steps":["trace[802469835] 'process raft request'  (duration: 103.084997ms)","trace[802469835] 'compare'  (duration: 36.399285ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:19.440294Z","caller":"traceutil/trace.go:171","msg":"trace[1998536160] linearizableReadLoop","detail":"{readStateIndex:28863; appliedIndex:28861; }","duration":"116.271347ms","start":"2026-09-12T07:32:19.323988Z","end":"2026-09-12T07:32:19.440259Z","steps":["trace[1998536160] 'read index received'  (duration: 115.95054ms)","trace[1998536160] 'applied index is now lower than readState.Index'  (duration: 319.107µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:19.440329Z","caller":"traceutil/trace.go:171","msg":"trace[638560527] transaction","detail":"{read_only:false; response_revision:27929; number_of_response:1; }","duration":"297.319355ms","start":"2026-09-12T07:32:19.142954Z","end":"2026-09-12T07:32:19.440273Z","steps":["trace[638560527] 'process raft request'  (duration: 296.960958ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:19.440374Z","caller":"traceutil/trace.go:171","msg":"trace[997884238] transaction","detail":"{read_only:false; response_revision:27930; number_of_response:1; }","duration":"292.955832ms","start":"2026-09-12T07:32:19.147391Z","end":"2026-09-12T07:32:19.440347Z","steps":["trace[997884238] 'process raft request'  (duration: 292.747777ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:19.440467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.450011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:32:19.440522Z","caller":"traceutil/trace.go:171","msg":"trace[1730089122] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:27930; }","duration":"116.573564ms","start":"2026-09-12T07:32:19.32393Z","end":"2026-09-12T07:32:19.440503Z","steps":["trace[1730089122] 'agreement among raft nodes before linearized reading'  (duration: 116.453551ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:19.557921Z","caller":"traceutil/trace.go:171","msg":"trace[1849457630] transaction","detail":"{read_only:false; response_revision:27932; number_of_response:1; }","duration":"111.350843ms","start":"2026-09-12T07:32:19.446535Z","end":"2026-09-12T07:32:19.557886Z","steps":["trace[1849457630] 'process raft request'  (duration: 111.025946ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:19.558119Z","caller":"traceutil/trace.go:171","msg":"trace[481027029] transaction","detail":"{read_only:false; response_revision:27933; number_of_response:1; }","duration":"109.35525ms","start":"2026-09-12T07:32:19.448726Z","end":"2026-09-12T07:32:19.558081Z","steps":["trace[481027029] 'process raft request'  (duration: 109.085364ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:19.79312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.762981ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452729604 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:27909 > 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-09-12T07:32:19.793405Z","caller":"traceutil/trace.go:171","msg":"trace[1171126449] transaction","detail":"{read_only:false; response_revision:27934; number_of_response:1; }","duration":"313.344927ms","start":"2026-09-12T07:32:19.480009Z","end":"2026-09-12T07:32:19.793354Z","steps":["trace[1171126449] 'process raft request'  (duration: 210.21684ms)","trace[1171126449] 'compare'  (duration: 102.510084ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:32:19.793581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.479987Z","time spent":"313.50355ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:27909 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-09-12T07:32:19.793599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.711488ms","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-09-12T07:32:19.793637Z","caller":"traceutil/trace.go:171","msg":"trace[397226710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27935; }","duration":"255.80162ms","start":"2026-09-12T07:32:19.537824Z","end":"2026-09-12T07:32:19.793626Z","steps":["trace[397226710] 'agreement among raft nodes before linearized reading'  (duration: 255.641587ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:19.793439Z","caller":"traceutil/trace.go:171","msg":"trace[639456583] linearizableReadLoop","detail":"{readStateIndex:28868; appliedIndex:28864; }","duration":"255.521485ms","start":"2026-09-12T07:32:19.537897Z","end":"2026-09-12T07:32:19.793418Z","steps":["trace[639456583] 'read index received'  (duration: 19.604088ms)","trace[639456583] 'applied index is now lower than readState.Index'  (duration: 235.915787ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:19.793613Z","caller":"traceutil/trace.go:171","msg":"trace[1190737544] transaction","detail":"{read_only:false; response_revision:27935; number_of_response:1; }","duration":"259.10335ms","start":"2026-09-12T07:32:19.534477Z","end":"2026-09-12T07:32:19.793581Z","steps":["trace[1190737544] 'process raft request'  (duration: 258.813654ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:20.044774Z","caller":"traceutil/trace.go:171","msg":"trace[1509021364] transaction","detail":"{read_only:false; response_revision:27936; number_of_response:1; }","duration":"478.21121ms","start":"2026-09-12T07:32:19.566503Z","end":"2026-09-12T07:32:20.044715Z","steps":["trace[1509021364] 'process raft request'  (duration: 412.365186ms)","trace[1509021364] 'compare'  (duration: 65.513477ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:32:20.045041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.566476Z","time spent":"478.405674ms","remote":"127.0.0.1:60000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3020,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/deployments/openstack/magnum-registry\" mod_revision:27078 > success:<request_put:<key:\"/registry/deployments/openstack/magnum-registry\" value_size:2965 >> failure:<request_range:<key:\"/registry/deployments/openstack/magnum-registry\" > >"}
{"level":"info","ts":"2026-09-12T07:32:20.338263Z","caller":"traceutil/trace.go:171","msg":"trace[1340657832] transaction","detail":"{read_only:false; response_revision:27937; number_of_response:1; }","duration":"539.652939ms","start":"2026-09-12T07:32:19.798572Z","end":"2026-09-12T07:32:20.338225Z","steps":["trace[1340657832] 'process raft request'  (duration: 513.148914ms)","trace[1340657832] 'compare'  (duration: 25.915812ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:20.338341Z","caller":"traceutil/trace.go:171","msg":"trace[1397137155] transaction","detail":"{read_only:false; response_revision:27938; number_of_response:1; }","duration":"439.457464ms","start":"2026-09-12T07:32:19.89886Z","end":"2026-09-12T07:32:20.338317Z","steps":["trace[1397137155] 'process raft request'  (duration: 439.23645ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:20.338469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.798552Z","time spent":"539.797113ms","remote":"127.0.0.1:59826","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:27911 > 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-09-12T07:32:20.338465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.898798Z","time spent":"439.592357ms","remote":"127.0.0.1:59826","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:27915 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-12T07:32:20.338464Z","caller":"traceutil/trace.go:171","msg":"trace[1105606930] transaction","detail":"{read_only:false; response_revision:27939; number_of_response:1; }","duration":"386.670919ms","start":"2026-09-12T07:32:19.951751Z","end":"2026-09-12T07:32:20.338422Z","steps":["trace[1105606930] 'process raft request'  (duration: 386.478385ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:20.338489Z","caller":"traceutil/trace.go:171","msg":"trace[1208675711] linearizableReadLoop","detail":"{readStateIndex:28871; appliedIndex:28868; }","duration":"403.974768ms","start":"2026-09-12T07:32:19.934486Z","end":"2026-09-12T07:32:20.33846Z","steps":["trace[1208675711] 'read index received'  (duration: 44.398486ms)","trace[1208675711] 'applied index is now lower than readState.Index'  (duration: 359.574692ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T07:32:20.338621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.951723Z","time spent":"386.815033ms","remote":"127.0.0.1:59826","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:27916 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-09-12T07:32:20.338654Z","caller":"traceutil/trace.go:171","msg":"trace[576223417] transaction","detail":"{read_only:false; response_revision:27943; number_of_response:1; }","duration":"376.742898ms","start":"2026-09-12T07:32:19.961899Z","end":"2026-09-12T07:32:20.338642Z","steps":["trace[576223417] 'process raft request'  (duration: 376.525773ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:20.33871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.961876Z","time spent":"376.80415ms","remote":"127.0.0.1:59826","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:27919 > 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-09-12T07:32:20.338739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.238333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:32:20.338699Z","caller":"traceutil/trace.go:171","msg":"trace[2114080677] transaction","detail":"{read_only:false; response_revision:27941; number_of_response:1; }","duration":"378.413863ms","start":"2026-09-12T07:32:19.960244Z","end":"2026-09-12T07:32:20.338658Z","steps":["trace[2114080677] 'process raft request'  (duration: 378.117307ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:20.338801Z","caller":"traceutil/trace.go:171","msg":"trace[541377293] transaction","detail":"{read_only:false; response_revision:27942; number_of_response:1; }","duration":"377.377842ms","start":"2026-09-12T07:32:19.961411Z","end":"2026-09-12T07:32:20.338789Z","steps":["trace[541377293] 'process raft request'  (duration: 376.981914ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:20.33884Z","caller":"traceutil/trace.go:171","msg":"trace[1692812448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27943; }","duration":"404.347706ms","start":"2026-09-12T07:32:19.934438Z","end":"2026-09-12T07:32:20.338786Z","steps":["trace[1692812448] 'agreement among raft nodes before linearized reading'  (duration: 404.238384ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:20.338652Z","caller":"traceutil/trace.go:171","msg":"trace[1692491430] transaction","detail":"{read_only:false; response_revision:27940; number_of_response:1; }","duration":"380.12399ms","start":"2026-09-12T07:32:19.95851Z","end":"2026-09-12T07:32:20.338634Z","steps":["trace[1692491430] 'process raft request'  (duration: 379.759912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:20.338871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.961388Z","time spent":"377.455523ms","remote":"127.0.0.1:59826","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/capi-system/controller-leader-election-capi\" mod_revision:27920 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-09-12T07:32:20.338886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.934417Z","time spent":"404.459178ms","remote":"127.0.0.1:59586","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-09-12T07:32:20.338795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.214108ms","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-09-12T07:32:20.33895Z","caller":"traceutil/trace.go:171","msg":"trace[777341155] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:27943; }","duration":"369.396561ms","start":"2026-09-12T07:32:19.969539Z","end":"2026-09-12T07:32:20.338935Z","steps":["trace[777341155] 'agreement among raft nodes before linearized reading'  (duration: 369.212287ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:20.338953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.960217Z","time spent":"378.620558ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:27818 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"warn","ts":"2026-09-12T07:32:20.338997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.969525Z","time spent":"369.461853ms","remote":"127.0.0.1:48256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true "}
{"level":"warn","ts":"2026-09-12T07:32:20.338982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T07:32:19.958483Z","time spent":"380.414846ms","remote":"127.0.0.1:59826","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:27918 > 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-09-12T07:32:20.339116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.740059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T07:32:20.339192Z","caller":"traceutil/trace.go:171","msg":"trace[2034139436] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:27943; }","duration":"201.825191ms","start":"2026-09-12T07:32:20.137325Z","end":"2026-09-12T07:32:20.33915Z","steps":["trace[2034139436] 'agreement among raft nodes before linearized reading'  (duration: 201.759719ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:46.679893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.240496ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9396655706452730388 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0267a09453c32213>","response":"size:41"}
{"level":"info","ts":"2026-09-12T07:32:46.687357Z","caller":"traceutil/trace.go:171","msg":"trace[1068833704] transaction","detail":"{read_only:false; response_revision:28270; number_of_response:1; }","duration":"221.872428ms","start":"2026-09-12T07:32:46.465459Z","end":"2026-09-12T07:32:46.687331Z","steps":["trace[1068833704] 'process raft request'  (duration: 221.790586ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:46.687396Z","caller":"traceutil/trace.go:171","msg":"trace[749253989] transaction","detail":"{read_only:false; response_revision:28269; number_of_response:1; }","duration":"236.224744ms","start":"2026-09-12T07:32:46.451106Z","end":"2026-09-12T07:32:46.687331Z","steps":["trace[749253989] 'process raft request'  (duration: 235.960768ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:46.687673Z","caller":"traceutil/trace.go:171","msg":"trace[1391674389] transaction","detail":"{read_only:false; response_revision:28271; number_of_response:1; }","duration":"222.125584ms","start":"2026-09-12T07:32:46.465518Z","end":"2026-09-12T07:32:46.687643Z","steps":["trace[1391674389] 'process raft request'  (duration: 221.775596ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:46.687957Z","caller":"traceutil/trace.go:171","msg":"trace[207499072] transaction","detail":"{read_only:false; response_revision:28272; number_of_response:1; }","duration":"220.777935ms","start":"2026-09-12T07:32:46.467163Z","end":"2026-09-12T07:32:46.687941Z","steps":["trace[207499072] 'process raft request'  (duration: 220.378696ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:32:46.68798Z","caller":"traceutil/trace.go:171","msg":"trace[104797524] linearizableReadLoop","detail":"{readStateIndex:29214; appliedIndex:29208; }","duration":"203.792083ms","start":"2026-09-12T07:32:46.484168Z","end":"2026-09-12T07:32:46.68796Z","steps":["trace[104797524] 'read index received'  (duration: 57.484045ms)","trace[104797524] 'applied index is now lower than readState.Index'  (duration: 146.306858ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T07:32:46.68796Z","caller":"traceutil/trace.go:171","msg":"trace[731975533] transaction","detail":"{read_only:false; response_revision:28273; number_of_response:1; }","duration":"217.168158ms","start":"2026-09-12T07:32:46.470752Z","end":"2026-09-12T07:32:46.68792Z","steps":["trace[731975533] 'process raft request'  (duration: 216.972634ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:46.688244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.075378ms","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-09-12T07:32:46.688291Z","caller":"traceutil/trace.go:171","msg":"trace[1792202565] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:28274; }","duration":"204.180151ms","start":"2026-09-12T07:32:46.484098Z","end":"2026-09-12T07:32:46.688278Z","steps":["trace[1792202565] 'agreement among raft nodes before linearized reading'  (duration: 204.011467ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:46.688454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.746244ms","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-09-12T07:32:46.688538Z","caller":"traceutil/trace.go:171","msg":"trace[1263072589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:28274; }","duration":"174.926688ms","start":"2026-09-12T07:32:46.513592Z","end":"2026-09-12T07:32:46.688518Z","steps":["trace[1263072589] 'agreement among raft nodes before linearized reading'  (duration: 174.668912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T07:32:46.68861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.134803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7914"}
{"level":"info","ts":"2026-09-12T07:32:46.688675Z","caller":"traceutil/trace.go:171","msg":"trace[702998504] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:28274; }","duration":"122.276177ms","start":"2026-09-12T07:32:46.566381Z","end":"2026-09-12T07:32:46.688657Z","steps":["trace[702998504] 'agreement among raft nodes before linearized reading'  (duration: 122.032771ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:34:16.220341Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51815f4ecef28267","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T07:34:16.227143Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-12T07:34:16.227235Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-09-12T07:35:13.104371Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26775}
{"level":"info","ts":"2026-09-12T07:35:13.264672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26775,"took":"156.28557ms","hash":2829126443,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":37789696,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-09-12T07:35:13.264746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2829126443,"revision":26775,"compact-revision":23542}
{"level":"info","ts":"2026-09-12T07:36:22.123313Z","caller":"traceutil/trace.go:171","msg":"trace[2056649674] transaction","detail":"{read_only:false; response_revision:30387; number_of_response:1; }","duration":"110.361271ms","start":"2026-09-12T07:36:22.01292Z","end":"2026-09-12T07:36:22.123281Z","steps":["trace[2056649674] 'process raft request'  (duration: 110.170057ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T07:40:13.111985Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29609}
{"level":"info","ts":"2026-09-12T07:40:13.267645Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29609,"took":"151.216971ms","hash":4252405647,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":32911360,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-09-12T07:40:13.267731Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4252405647,"revision":29609,"compact-revision":26775}
{"level":"info","ts":"2026-09-12T07:45:13.120441Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32144}
{"level":"info","ts":"2026-09-12T07:45:13.286603Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32144,"took":"162.659077ms","hash":2749225618,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":30580736,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-12T07:45:13.286658Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2749225618,"revision":32144,"compact-revision":29609}
{"level":"info","ts":"2026-09-12T07:50:13.127264Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34374}
{"level":"info","ts":"2026-09-12T07:50:13.2764Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34374,"took":"144.706486ms","hash":971466773,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":30498816,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T07:50:13.276462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":971466773,"revision":34374,"compact-revision":32144}
{"level":"info","ts":"2026-09-12T07:54:55.05047Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51815f4ecef28267","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T07:54:55.056592Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-09-12T07:54:55.056741Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-09-12T07:55:13.135831Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36608}
{"level":"info","ts":"2026-09-12T07:55:13.265362Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36608,"took":"125.536397ms","hash":1583875028,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":31526912,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-12T07:55:13.265434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1583875028,"revision":36608,"compact-revision":34374}
{"level":"info","ts":"2026-09-12T08:00:13.143103Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":38943}
{"level":"info","ts":"2026-09-12T08:00:13.279624Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":38943,"took":"132.178111ms","hash":3529582029,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":30887936,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-12T08:00:13.279687Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3529582029,"revision":38943,"compact-revision":36608}