{"level":"warn","ts":"2026-10-06T10:07:10.060745Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-06T10:07:10.060862Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.20: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.20:2380","--initial-cluster=instance=https://162.253.55.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.20: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-10-06T10:07:10.060941Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-06T10:07:10.060951Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.20:2380"]}
{"level":"info","ts":"2026-10-06T10:07:10.060977Z","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-10-06T10:07:10.061836Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"]}
{"level":"info","ts":"2026-10-06T10:07:10.061961Z","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.20:2380"],"listen-peer-urls":["https://162.253.55.20:2380"],"advertise-client-urls":["https://162.253.55.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.20: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-10-06T10:07:10.066009Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.176808ms"}
{"level":"info","ts":"2026-10-06T10:07:10.074298Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eae99266654eff69","cluster-id":"6d4184aac664e4ac"}
{"level":"info","ts":"2026-10-06T10:07:10.074401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-06T10:07:10.074426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became follower at term 0"}
{"level":"info","ts":"2026-10-06T10:07:10.074446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eae99266654eff69 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-06T10:07:10.074463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became follower at term 1"}
{"level":"info","ts":"2026-10-06T10:07:10.074522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=(16927221642932715369)"}
{"level":"warn","ts":"2026-10-06T10:07:10.086528Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-06T10:07:10.089335Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-06T10:07:10.090695Z","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-10-06T10:07:10.093762Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eae99266654eff69","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-06T10:07:10.094103Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eae99266654eff69","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-06T10:07:10.094447Z","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-10-06T10:07:10.094551Z","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-10-06T10:07:10.094568Z","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-10-06T10:07:10.09688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=(16927221642932715369)"}
{"level":"info","ts":"2026-10-06T10:07:10.097084Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6d4184aac664e4ac","local-member-id":"eae99266654eff69","added-peer-id":"eae99266654eff69","added-peer-peer-urls":["https://162.253.55.20:2380"]}
{"level":"info","ts":"2026-10-06T10:07:10.10084Z","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-10-06T10:07:10.101079Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.20:2380"}
{"level":"info","ts":"2026-10-06T10:07:10.101157Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.20:2380"}
{"level":"info","ts":"2026-10-06T10:07:10.101231Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eae99266654eff69","initial-advertise-peer-urls":["https://162.253.55.20:2380"],"listen-peer-urls":["https://162.253.55.20:2380"],"advertise-client-urls":["https://162.253.55.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-06T10:07:10.101298Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-06T10:07:10.575722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-06T10:07:10.575797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-06T10:07:10.575843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 received MsgPreVoteResp from eae99266654eff69 at term 1"}
{"level":"info","ts":"2026-10-06T10:07:10.575868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became candidate at term 2"}
{"level":"info","ts":"2026-10-06T10:07:10.575884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 received MsgVoteResp from eae99266654eff69 at term 2"}
{"level":"info","ts":"2026-10-06T10:07:10.575911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became leader at term 2"}
{"level":"info","ts":"2026-10-06T10:07:10.575928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eae99266654eff69 elected leader eae99266654eff69 at term 2"}
{"level":"info","ts":"2026-10-06T10:07:10.577238Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eae99266654eff69","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.20:2379]}","request-path":"/0/members/eae99266654eff69/attributes","cluster-id":"6d4184aac664e4ac","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-06T10:07:10.577277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-06T10:07:10.577424Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-06T10:07:10.577433Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-06T10:07:10.577604Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-06T10:07:10.577633Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-06T10:07:10.578824Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6d4184aac664e4ac","local-member-id":"eae99266654eff69","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-06T10:07:10.578962Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-06T10:07:10.579037Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-06T10:07:10.579094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-06T10:07:10.597764Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.20:2379"}
{"level":"info","ts":"2026-10-06T10:07:28.192494Z","caller":"traceutil/trace.go:171","msg":"trace[56734817] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"115.620797ms","start":"2026-10-06T10:07:28.076846Z","end":"2026-10-06T10:07:28.192466Z","steps":["trace[56734817] 'process raft request'  (duration: 115.435834ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:07:28.41353Z","caller":"traceutil/trace.go:171","msg":"trace[881436964] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"205.425902ms","start":"2026-10-06T10:07:28.208078Z","end":"2026-10-06T10:07:28.413504Z","steps":["trace[881436964] 'process raft request'  (duration: 205.137437ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:07:55.359815Z","caller":"traceutil/trace.go:171","msg":"trace[2014195496] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"142.446461ms","start":"2026-10-06T10:07:55.217328Z","end":"2026-10-06T10:07:55.359775Z","steps":["trace[2014195496] 'read index received'  (duration: 98.913032ms)","trace[2014195496] 'applied index is now lower than readState.Index'  (duration: 43.531519ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:07:55.360027Z","caller":"traceutil/trace.go:171","msg":"trace[1868937833] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"157.233309ms","start":"2026-10-06T10:07:55.202763Z","end":"2026-10-06T10:07:55.359997Z","steps":["trace[1868937833] 'process raft request'  (duration: 113.638359ms)","trace[1868937833] 'compare'  (duration: 43.211424ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:07:55.360081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.700246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:07:55.360165Z","caller":"traceutil/trace.go:171","msg":"trace[1731924153] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:630; }","duration":"142.850078ms","start":"2026-10-06T10:07:55.217299Z","end":"2026-10-06T10:07:55.360149Z","steps":["trace[1731924153] 'agreement among raft nodes before linearized reading'  (duration: 142.644264ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:07:56.11406Z","caller":"traceutil/trace.go:171","msg":"trace[866105716] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"248.956421ms","start":"2026-10-06T10:07:55.865065Z","end":"2026-10-06T10:07:56.114021Z","steps":["trace[866105716] 'read index received'  (duration: 247.558386ms)","trace[866105716] 'applied index is now lower than readState.Index'  (duration: 1.396455ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:07:56.114262Z","caller":"traceutil/trace.go:171","msg":"trace[1305662071] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"275.520792ms","start":"2026-10-06T10:07:55.838724Z","end":"2026-10-06T10:07:56.114245Z","steps":["trace[1305662071] 'process raft request'  (duration: 274.27886ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:07:56.11481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.720605ms","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-10-06T10:07:56.114966Z","caller":"traceutil/trace.go:171","msg":"trace[769290161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"249.927508ms","start":"2026-10-06T10:07:55.865003Z","end":"2026-10-06T10:07:56.114931Z","steps":["trace[769290161] 'agreement among raft nodes before linearized reading'  (duration: 249.555572ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:07:56.320598Z","caller":"traceutil/trace.go:171","msg":"trace[205953942] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"130.014956ms","start":"2026-10-06T10:07:56.190534Z","end":"2026-10-06T10:07:56.320549Z","steps":["trace[205953942] 'process raft request'  (duration: 114.725988ms)","trace[205953942] 'compare'  (duration: 15.048004ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:09:36.532623Z","caller":"traceutil/trace.go:171","msg":"trace[1246807835] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1984; }","duration":"111.834632ms","start":"2026-10-06T10:09:36.420723Z","end":"2026-10-06T10:09:36.532558Z","steps":["trace[1246807835] 'read index received'  (duration: 111.600668ms)","trace[1246807835] 'applied index is now lower than readState.Index'  (duration: 232.204µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:09:36.532869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.114887ms","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-10-06T10:09:36.532923Z","caller":"traceutil/trace.go:171","msg":"trace[1172510074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"112.22322ms","start":"2026-10-06T10:09:36.420683Z","end":"2026-10-06T10:09:36.532907Z","steps":["trace[1172510074] 'agreement among raft nodes before linearized reading'  (duration: 112.006585ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:09:36.532657Z","caller":"traceutil/trace.go:171","msg":"trace[2031851772] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"153.055672ms","start":"2026-10-06T10:09:36.379576Z","end":"2026-10-06T10:09:36.532632Z","steps":["trace[2031851772] 'process raft request'  (duration: 152.785227ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:09:36.894826Z","caller":"traceutil/trace.go:171","msg":"trace[1935158716] linearizableReadLoop","detail":"{readStateIndex:1989; appliedIndex:1988; }","duration":"178.890526ms","start":"2026-10-06T10:09:36.715907Z","end":"2026-10-06T10:09:36.894798Z","steps":["trace[1935158716] 'read index received'  (duration: 178.53985ms)","trace[1935158716] 'applied index is now lower than readState.Index'  (duration: 349.316µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:09:36.895103Z","caller":"traceutil/trace.go:171","msg":"trace[1722351438] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"182.241379ms","start":"2026-10-06T10:09:36.71281Z","end":"2026-10-06T10:09:36.895051Z","steps":["trace[1722351438] 'process raft request'  (duration: 181.657838ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:09:36.895356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.633562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-06T10:09:36.895498Z","caller":"traceutil/trace.go:171","msg":"trace[727424880] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1919; }","duration":"170.907477ms","start":"2026-10-06T10:09:36.72456Z","end":"2026-10-06T10:09:36.895467Z","steps":["trace[727424880] 'agreement among raft nodes before linearized reading'  (duration: 170.644073ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:09:36.895786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.288747ms","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-10-06T10:09:36.895913Z","caller":"traceutil/trace.go:171","msg":"trace[1709683605] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1919; }","duration":"130.46832ms","start":"2026-10-06T10:09:36.765406Z","end":"2026-10-06T10:09:36.895874Z","steps":["trace[1709683605] 'agreement among raft nodes before linearized reading'  (duration: 130.029182ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:09:36.895914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.988187ms","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-10-06T10:09:36.896Z","caller":"traceutil/trace.go:171","msg":"trace[960974610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1919; }","duration":"180.126009ms","start":"2026-10-06T10:09:36.715857Z","end":"2026-10-06T10:09:36.895983Z","steps":["trace[960974610] 'agreement among raft nodes before linearized reading'  (duration: 179.65313ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:09:48.76844Z","caller":"traceutil/trace.go:171","msg":"trace[311133291] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"143.246859ms","start":"2026-10-06T10:09:48.625167Z","end":"2026-10-06T10:09:48.768414Z","steps":["trace[311133291] 'process raft request'  (duration: 122.451951ms)","trace[311133291] 'compare'  (duration: 20.637876ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:09:48.768595Z","caller":"traceutil/trace.go:171","msg":"trace[1747271664] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"131.041272ms","start":"2026-10-06T10:09:48.637495Z","end":"2026-10-06T10:09:48.768537Z","steps":["trace[1747271664] 'process raft request'  (duration: 130.875049ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:09:49.23432Z","caller":"traceutil/trace.go:171","msg":"trace[1395546871] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"148.533599ms","start":"2026-10-06T10:09:49.085729Z","end":"2026-10-06T10:09:49.234263Z","steps":["trace[1395546871] 'process raft request'  (duration: 131.267465ms)","trace[1395546871] 'compare'  (duration: 16.850886ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:10:27.458841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.395439ms","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-10-06T10:10:27.458935Z","caller":"traceutil/trace.go:171","msg":"trace[1192384132] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2243; }","duration":"168.554822ms","start":"2026-10-06T10:10:27.290358Z","end":"2026-10-06T10:10:27.458913Z","steps":["trace[1192384132] 'range keys from in-memory index tree'  (duration: 168.185904ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:10:33.372473Z","caller":"traceutil/trace.go:171","msg":"trace[632582971] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"118.404973ms","start":"2026-10-06T10:10:33.254032Z","end":"2026-10-06T10:10:33.372437Z","steps":["trace[632582971] 'process raft request'  (duration: 118.194509ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:11:23.235966Z","caller":"traceutil/trace.go:171","msg":"trace[140707036] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"117.822628ms","start":"2026-10-06T10:11:23.118115Z","end":"2026-10-06T10:11:23.235938Z","steps":["trace[140707036] 'process raft request'  (duration: 117.656735ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:11:23.298865Z","caller":"traceutil/trace.go:171","msg":"trace[1400377743] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"154.633688ms","start":"2026-10-06T10:11:23.1442Z","end":"2026-10-06T10:11:23.298833Z","steps":["trace[1400377743] 'process raft request'  (duration: 154.309493ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:11:57.206183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.893802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:11:57.206303Z","caller":"traceutil/trace.go:171","msg":"trace[221171781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2915; }","duration":"169.048985ms","start":"2026-10-06T10:11:57.037221Z","end":"2026-10-06T10:11:57.20627Z","steps":["trace[221171781] 'range keys from in-memory index tree'  (duration: 168.721679ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:11:57.206686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.384055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-06T10:11:57.206807Z","caller":"traceutil/trace.go:171","msg":"trace[2099194765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2915; }","duration":"219.588079ms","start":"2026-10-06T10:11:56.987194Z","end":"2026-10-06T10:11:57.206782Z","steps":["trace[2099194765] 'range keys from in-memory index tree'  (duration: 219.204592ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:11:57.209905Z","caller":"traceutil/trace.go:171","msg":"trace[1270416488] transaction","detail":"{read_only:false; response_revision:2916; number_of_response:1; }","duration":"136.363841ms","start":"2026-10-06T10:11:57.073513Z","end":"2026-10-06T10:11:57.209877Z","steps":["trace[1270416488] 'process raft request'  (duration: 135.992044ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:16:37.34258Z","caller":"traceutil/trace.go:171","msg":"trace[1452538124] transaction","detail":"{read_only:false; response_revision:5142; number_of_response:1; }","duration":"122.20986ms","start":"2026-10-06T10:16:37.220336Z","end":"2026-10-06T10:16:37.342546Z","steps":["trace[1452538124] 'process raft request'  (duration: 120.291193ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:16:41.390459Z","caller":"traceutil/trace.go:171","msg":"trace[1959583906] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"104.169781ms","start":"2026-10-06T10:16:41.286261Z","end":"2026-10-06T10:16:41.390431Z","steps":["trace[1959583906] 'process raft request'  (duration: 103.969558ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:16:59.812285Z","caller":"traceutil/trace.go:171","msg":"trace[906754059] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"135.465778ms","start":"2026-10-06T10:16:59.676768Z","end":"2026-10-06T10:16:59.812234Z","steps":["trace[906754059] 'process raft request'  (duration: 96.391766ms)","trace[906754059] 'compare'  (duration: 38.912689ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:17:00.360473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.879626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-j5wqg\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-10-06T10:17:00.360554Z","caller":"traceutil/trace.go:171","msg":"trace[504968159] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-j5wqg; range_end:; response_count:1; response_revision:5637; }","duration":"151.011808ms","start":"2026-10-06T10:17:00.209522Z","end":"2026-10-06T10:17:00.360534Z","steps":["trace[504968159] 'range keys from in-memory index tree'  (duration: 150.692711ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:17:07.813297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.676147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a738ac72-6690-4400-8fae-ad15862b01ce\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-10-06T10:17:07.813409Z","caller":"traceutil/trace.go:171","msg":"trace[703552418] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a738ac72-6690-4400-8fae-ad15862b01ce; range_end:; response_count:1; response_revision:5813; }","duration":"115.875171ms","start":"2026-10-06T10:17:07.697509Z","end":"2026-10-06T10:17:07.813384Z","steps":["trace[703552418] 'range keys from in-memory index tree'  (duration: 115.486994ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:17:08.477969Z","caller":"traceutil/trace.go:171","msg":"trace[1672282594] transaction","detail":"{read_only:false; response_revision:5815; number_of_response:1; }","duration":"163.166216ms","start":"2026-10-06T10:17:08.314708Z","end":"2026-10-06T10:17:08.477874Z","steps":["trace[1672282594] 'process raft request'  (duration: 162.967692ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:17:10.629828Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2991}
{"level":"info","ts":"2026-10-06T10:17:10.705224Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2991,"took":"73.790912ms","hash":951725226,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":32194560,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-06T10:17:10.705331Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":951725226,"revision":2991,"compact-revision":-1}
{"level":"info","ts":"2026-10-06T10:17:20.214977Z","caller":"traceutil/trace.go:171","msg":"trace[1939132056] linearizableReadLoop","detail":"{readStateIndex:6181; appliedIndex:6180; }","duration":"105.283612ms","start":"2026-10-06T10:17:20.109672Z","end":"2026-10-06T10:17:20.214956Z","steps":["trace[1939132056] 'read index received'  (duration: 105.095678ms)","trace[1939132056] 'applied index is now lower than readState.Index'  (duration: 187.294µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:17:20.215213Z","caller":"traceutil/trace.go:171","msg":"trace[847901700] transaction","detail":"{read_only:false; response_revision:5965; number_of_response:1; }","duration":"124.955271ms","start":"2026-10-06T10:17:20.090211Z","end":"2026-10-06T10:17:20.215166Z","steps":["trace[847901700] 'process raft request'  (duration: 124.603094ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:17:20.215299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.586038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-49qpd\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-10-06T10:17:20.215514Z","caller":"traceutil/trace.go:171","msg":"trace[571403313] range","detail":"{range_begin:/registry/pods/openstack/keepalived-49qpd; range_end:; response_count:1; response_revision:5965; }","duration":"105.865183ms","start":"2026-10-06T10:17:20.109634Z","end":"2026-10-06T10:17:20.215499Z","steps":["trace[571403313] 'agreement among raft nodes before linearized reading'  (duration: 105.413575ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:18:00.619021Z","caller":"traceutil/trace.go:171","msg":"trace[1150731973] transaction","detail":"{read_only:false; response_revision:6312; number_of_response:1; }","duration":"129.175031ms","start":"2026-10-06T10:18:00.489826Z","end":"2026-10-06T10:18:00.619001Z","steps":["trace[1150731973] 'process raft request'  (duration: 129.022208ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:22:10.637074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5857}
{"level":"info","ts":"2026-10-06T10:22:10.730502Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5857,"took":"91.621173ms","hash":1294544021,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":26894336,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-06T10:22:10.730573Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1294544021,"revision":5857,"compact-revision":2991}
{"level":"warn","ts":"2026-10-06T10:23:19.511385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.277414ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244451456 > lease_revoke:<id:7f69a110ae7148c6>","response":"size:28"}
{"level":"info","ts":"2026-10-06T10:23:19.511492Z","caller":"traceutil/trace.go:171","msg":"trace[1201502746] linearizableReadLoop","detail":"{readStateIndex:8966; appliedIndex:8965; }","duration":"208.406231ms","start":"2026-10-06T10:23:19.303069Z","end":"2026-10-06T10:23:19.511475Z","steps":["trace[1201502746] 'read index received'  (duration: 74.861782ms)","trace[1201502746] 'applied index is now lower than readState.Index'  (duration: 133.542869ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:23:19.511712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.631345ms","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-10-06T10:23:19.511746Z","caller":"traceutil/trace.go:171","msg":"trace[699789722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8661; }","duration":"208.706946ms","start":"2026-10-06T10:23:19.303029Z","end":"2026-10-06T10:23:19.511736Z","steps":["trace[699789722] 'agreement among raft nodes before linearized reading'  (duration: 208.556223ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:23:19.511754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.901734ms","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-10-06T10:23:19.511838Z","caller":"traceutil/trace.go:171","msg":"trace[352357556] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8661; }","duration":"188.019986ms","start":"2026-10-06T10:23:19.323799Z","end":"2026-10-06T10:23:19.511818Z","steps":["trace[352357556] 'agreement among raft nodes before linearized reading'  (duration: 187.807112ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:23:32.193982Z","caller":"traceutil/trace.go:171","msg":"trace[1487683468] linearizableReadLoop","detail":"{readStateIndex:9037; appliedIndex:9036; }","duration":"156.96277ms","start":"2026-10-06T10:23:32.036979Z","end":"2026-10-06T10:23:32.193941Z","steps":["trace[1487683468] 'read index received'  (duration: 116.892395ms)","trace[1487683468] 'applied index is now lower than readState.Index'  (duration: 40.068595ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:23:32.193997Z","caller":"traceutil/trace.go:171","msg":"trace[250742719] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"166.633273ms","start":"2026-10-06T10:23:32.027337Z","end":"2026-10-06T10:23:32.19397Z","steps":["trace[250742719] 'process raft request'  (duration: 126.555407ms)","trace[250742719] 'compare'  (duration: 39.493505ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:23:32.194129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.138273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:23:32.19421Z","caller":"traceutil/trace.go:171","msg":"trace[1462567434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8729; }","duration":"157.258436ms","start":"2026-10-06T10:23:32.036926Z","end":"2026-10-06T10:23:32.194184Z","steps":["trace[1462567434] 'agreement among raft nodes before linearized reading'  (duration: 157.117603ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:23:32.219318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.278381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:23:32.219402Z","caller":"traceutil/trace.go:171","msg":"trace[17194231] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8730; }","duration":"100.399054ms","start":"2026-10-06T10:23:32.118981Z","end":"2026-10-06T10:23:32.21938Z","steps":["trace[17194231] 'agreement among raft nodes before linearized reading'  (duration: 100.251271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:23:32.900849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.636738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-5c44bbc866-k5spb.18dbe9a9e82abdbf\" ","response":"range_response_count:1 size:1134"}
{"level":"info","ts":"2026-10-06T10:23:32.900962Z","caller":"traceutil/trace.go:171","msg":"trace[1773035119] range","detail":"{range_begin:/registry/events/openstack/barbican-api-5c44bbc866-k5spb.18dbe9a9e82abdbf; range_end:; response_count:1; response_revision:8732; }","duration":"135.79626ms","start":"2026-10-06T10:23:32.765138Z","end":"2026-10-06T10:23:32.900934Z","steps":["trace[1773035119] 'range keys from in-memory index tree'  (duration: 135.407803ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:23:56.550513Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002402.wal"}
{"level":"info","ts":"2026-10-06T10:23:59.919662Z","caller":"traceutil/trace.go:171","msg":"trace[1624810158] transaction","detail":"{read_only:false; response_revision:8930; number_of_response:1; }","duration":"102.191455ms","start":"2026-10-06T10:23:59.817447Z","end":"2026-10-06T10:23:59.919639Z","steps":["trace[1624810158] 'process raft request'  (duration: 101.963841ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:24:00.114844Z","caller":"traceutil/trace.go:171","msg":"trace[1244947522] transaction","detail":"{read_only:false; response_revision:8931; number_of_response:1; }","duration":"296.700382ms","start":"2026-10-06T10:23:59.818116Z","end":"2026-10-06T10:24:00.114817Z","steps":["trace[1244947522] 'process raft request'  (duration: 296.426467ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:24:00.114975Z","caller":"traceutil/trace.go:171","msg":"trace[1238972878] linearizableReadLoop","detail":"{readStateIndex:9249; appliedIndex:9246; }","duration":"230.25823ms","start":"2026-10-06T10:23:59.884697Z","end":"2026-10-06T10:24:00.114955Z","steps":["trace[1238972878] 'read index received'  (duration: 34.736074ms)","trace[1238972878] 'applied index is now lower than readState.Index'  (duration: 195.520066ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:24:00.115072Z","caller":"traceutil/trace.go:171","msg":"trace[262397155] transaction","detail":"{read_only:false; response_revision:8932; number_of_response:1; }","duration":"290.481535ms","start":"2026-10-06T10:23:59.82454Z","end":"2026-10-06T10:24:00.115021Z","steps":["trace[262397155] 'process raft request'  (duration: 290.23104ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:24:00.115235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.503024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-06T10:24:00.115334Z","caller":"traceutil/trace.go:171","msg":"trace[1507482707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8932; }","duration":"230.671517ms","start":"2026-10-06T10:23:59.884643Z","end":"2026-10-06T10:24:00.115314Z","steps":["trace[1507482707] 'agreement among raft nodes before linearized reading'  (duration: 230.392082ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:24:03.526321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.440598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:24:03.526423Z","caller":"traceutil/trace.go:171","msg":"trace[45093010] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8949; }","duration":"174.565201ms","start":"2026-10-06T10:24:03.351827Z","end":"2026-10-06T10:24:03.526392Z","steps":["trace[45093010] 'count revisions from in-memory index tree'  (duration: 174.334376ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:24:14.132252Z","caller":"traceutil/trace.go:171","msg":"trace[1578696479] transaction","detail":"{read_only:false; response_revision:9014; number_of_response:1; }","duration":"153.204018ms","start":"2026-10-06T10:24:13.979018Z","end":"2026-10-06T10:24:14.132222Z","steps":["trace[1578696479] 'process raft request'  (duration: 59.97127ms)","trace[1578696479] 'compare'  (duration: 93.109055ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:24:14.21203Z","caller":"traceutil/trace.go:171","msg":"trace[2146514175] linearizableReadLoop","detail":"{readStateIndex:9334; appliedIndex:9332; }","duration":"225.950199ms","start":"2026-10-06T10:24:13.98606Z","end":"2026-10-06T10:24:14.21201Z","steps":["trace[2146514175] 'read index received'  (duration: 52.967409ms)","trace[2146514175] 'applied index is now lower than readState.Index'  (duration: 172.98162ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:24:14.212483Z","caller":"traceutil/trace.go:171","msg":"trace[512519934] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9015; }","duration":"232.506992ms","start":"2026-10-06T10:24:13.979956Z","end":"2026-10-06T10:24:14.212463Z","steps":["trace[512519934] 'process raft request'  (duration: 231.89755ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:24:14.212467Z","caller":"traceutil/trace.go:171","msg":"trace[773846859] transaction","detail":"{read_only:false; response_revision:9016; number_of_response:1; }","duration":"204.396992ms","start":"2026-10-06T10:24:14.008022Z","end":"2026-10-06T10:24:14.212419Z","steps":["trace[773846859] 'process raft request'  (duration: 203.936043ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:24:14.212824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.755004ms","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-10-06T10:24:14.213098Z","caller":"traceutil/trace.go:171","msg":"trace[585972855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9016; }","duration":"226.980908ms","start":"2026-10-06T10:24:13.985998Z","end":"2026-10-06T10:24:14.212979Z","steps":["trace[585972855] 'agreement among raft nodes before linearized reading'  (duration: 226.52963ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:24:14.220592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.678243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:24:14.220672Z","caller":"traceutil/trace.go:171","msg":"trace[1386029584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9017; }","duration":"183.799414ms","start":"2026-10-06T10:24:14.03686Z","end":"2026-10-06T10:24:14.220659Z","steps":["trace[1386029584] 'agreement among raft nodes before linearized reading'  (duration: 183.691532ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:24:14.221081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.463233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-qpg8b\" ","response":"range_response_count:1 size:4647"}
{"level":"info","ts":"2026-10-06T10:24:14.221481Z","caller":"traceutil/trace.go:171","msg":"trace[340828350] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-qpg8b; range_end:; response_count:1; response_revision:9017; }","duration":"213.899551ms","start":"2026-10-06T10:24:14.007565Z","end":"2026-10-06T10:24:14.221464Z","steps":["trace[340828350] 'agreement among raft nodes before linearized reading'  (duration: 213.29052ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:25:15.570073Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"eae99266654eff69","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-06T10:25:15.577781Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-06T10:25:15.578081Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-06T10:27:10.647044Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8069}
{"level":"info","ts":"2026-10-06T10:27:10.751625Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8069,"took":"101.229495ms","hash":3429148175,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":28258304,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-06T10:27:10.751766Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3429148175,"revision":8069,"compact-revision":5857}
{"level":"info","ts":"2026-10-06T10:29:54.693039Z","caller":"traceutil/trace.go:171","msg":"trace[168928351] transaction","detail":"{read_only:false; response_revision:11487; number_of_response:1; }","duration":"196.761576ms","start":"2026-10-06T10:29:54.496246Z","end":"2026-10-06T10:29:54.693008Z","steps":["trace[168928351] 'process raft request'  (duration: 196.545292ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:32:10.655597Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10465}
{"level":"info","ts":"2026-10-06T10:32:10.760054Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10465,"took":"100.648355ms","hash":1335798649,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":25849856,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-06T10:32:10.76026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1335798649,"revision":10465,"compact-revision":8069}
{"level":"info","ts":"2026-10-06T10:37:10.669483Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12634}
{"level":"info","ts":"2026-10-06T10:37:10.752978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12634,"took":"80.939174ms","hash":1158254267,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":27340800,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-06T10:37:10.753049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1158254267,"revision":12634,"compact-revision":10465}
{"level":"info","ts":"2026-10-06T10:37:43.693865Z","caller":"traceutil/trace.go:171","msg":"trace[376057755] transaction","detail":"{read_only:false; response_revision:14851; number_of_response:1; }","duration":"126.146365ms","start":"2026-10-06T10:37:43.567689Z","end":"2026-10-06T10:37:43.693835Z","steps":["trace[376057755] 'process raft request'  (duration: 125.960131ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:37:43.782788Z","caller":"traceutil/trace.go:171","msg":"trace[2074642347] linearizableReadLoop","detail":"{readStateIndex:15366; appliedIndex:15364; }","duration":"209.856071ms","start":"2026-10-06T10:37:43.572908Z","end":"2026-10-06T10:37:43.782764Z","steps":["trace[2074642347] 'read index received'  (duration: 120.808624ms)","trace[2074642347] 'applied index is now lower than readState.Index'  (duration: 89.046647ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:37:43.782866Z","caller":"traceutil/trace.go:171","msg":"trace[2064098303] transaction","detail":"{read_only:false; response_revision:14852; number_of_response:1; }","duration":"213.574401ms","start":"2026-10-06T10:37:43.569253Z","end":"2026-10-06T10:37:43.782828Z","steps":["trace[2064098303] 'process raft request'  (duration: 213.358407ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:37:43.78301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.059895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-06T10:37:43.783036Z","caller":"traceutil/trace.go:171","msg":"trace[556449445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14852; }","duration":"210.153507ms","start":"2026-10-06T10:37:43.572874Z","end":"2026-10-06T10:37:43.783028Z","steps":["trace[556449445] 'agreement among raft nodes before linearized reading'  (duration: 209.986254ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:38:01.419729Z","caller":"traceutil/trace.go:171","msg":"trace[1534000498] transaction","detail":"{read_only:false; response_revision:14955; number_of_response:1; }","duration":"151.683406ms","start":"2026-10-06T10:38:01.267997Z","end":"2026-10-06T10:38:01.41968Z","steps":["trace[1534000498] 'process raft request'  (duration: 151.512192ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:41.064099Z","caller":"traceutil/trace.go:171","msg":"trace[452656755] transaction","detail":"{read_only:false; response_revision:16030; number_of_response:1; }","duration":"137.547389ms","start":"2026-10-06T10:39:40.926518Z","end":"2026-10-06T10:39:41.064065Z","steps":["trace[452656755] 'process raft request'  (duration: 137.356166ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:41.255793Z","caller":"traceutil/trace.go:171","msg":"trace[2019133664] linearizableReadLoop","detail":"{readStateIndex:16585; appliedIndex:16584; }","duration":"121.364564ms","start":"2026-10-06T10:39:41.1344Z","end":"2026-10-06T10:39:41.255764Z","steps":["trace[2019133664] 'read index received'  (duration: 121.13961ms)","trace[2019133664] 'applied index is now lower than readState.Index'  (duration: 223.404µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:39:41.256106Z","caller":"traceutil/trace.go:171","msg":"trace[77029678] transaction","detail":"{read_only:false; response_revision:16031; number_of_response:1; }","duration":"122.270771ms","start":"2026-10-06T10:39:41.133819Z","end":"2026-10-06T10:39:41.25609Z","steps":["trace[77029678] 'process raft request'  (duration: 121.748022ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:41.256417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.959765ms","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-10-06T10:39:41.256547Z","caller":"traceutil/trace.go:171","msg":"trace[2133183646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16031; }","duration":"122.155049ms","start":"2026-10-06T10:39:41.134362Z","end":"2026-10-06T10:39:41.256517Z","steps":["trace[2133183646] 'agreement among raft nodes before linearized reading'  (duration: 121.758842ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:42.179776Z","caller":"traceutil/trace.go:171","msg":"trace[427576288] linearizableReadLoop","detail":"{readStateIndex:16589; appliedIndex:16587; }","duration":"236.554555ms","start":"2026-10-06T10:39:41.943201Z","end":"2026-10-06T10:39:42.179755Z","steps":["trace[427576288] 'read index received'  (duration: 35.221684ms)","trace[427576288] 'applied index is now lower than readState.Index'  (duration: 201.331821ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:39:42.179896Z","caller":"traceutil/trace.go:171","msg":"trace[405379932] transaction","detail":"{read_only:false; response_revision:16035; number_of_response:1; }","duration":"275.490156ms","start":"2026-10-06T10:39:41.904395Z","end":"2026-10-06T10:39:42.179885Z","steps":["trace[405379932] 'process raft request'  (duration: 235.494194ms)","trace[405379932] 'compare'  (duration: 39.743567ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:39:42.180068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.85531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-10-06T10:39:42.180148Z","caller":"traceutil/trace.go:171","msg":"trace[815185941] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16035; }","duration":"237.001253ms","start":"2026-10-06T10:39:41.943128Z","end":"2026-10-06T10:39:42.180129Z","steps":["trace[815185941] 'agreement among raft nodes before linearized reading'  (duration: 236.757748ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:42.307315Z","caller":"traceutil/trace.go:171","msg":"trace[1037061173] transaction","detail":"{read_only:false; response_revision:16036; number_of_response:1; }","duration":"169.407939ms","start":"2026-10-06T10:39:42.137885Z","end":"2026-10-06T10:39:42.307293Z","steps":["trace[1037061173] 'process raft request'  (duration: 165.450765ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:42.311321Z","caller":"traceutil/trace.go:171","msg":"trace[1519584057] transaction","detail":"{read_only:false; response_revision:16037; number_of_response:1; }","duration":"134.8783ms","start":"2026-10-06T10:39:42.176415Z","end":"2026-10-06T10:39:42.311293Z","steps":["trace[1519584057] 'process raft request'  (duration: 134.590454ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:42.311426Z","caller":"traceutil/trace.go:171","msg":"trace[1332691789] linearizableReadLoop","detail":"{readStateIndex:16591; appliedIndex:16589; }","duration":"131.550867ms","start":"2026-10-06T10:39:42.179857Z","end":"2026-10-06T10:39:42.311408Z","steps":["trace[1332691789] 'read index received'  (duration: 123.608047ms)","trace[1332691789] 'applied index is now lower than readState.Index'  (duration: 7.94208ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:39:42.31191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.33528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-10-06T10:39:42.311902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.155968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-10-06T10:39:42.311966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.446682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.311984Z","caller":"traceutil/trace.go:171","msg":"trace[2034546121] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16038; }","duration":"364.480292ms","start":"2026-10-06T10:39:41.947498Z","end":"2026-10-06T10:39:42.311979Z","steps":["trace[2034546121] 'agreement among raft nodes before linearized reading'  (duration: 364.455492ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:42.311984Z","caller":"traceutil/trace.go:171","msg":"trace[841122135] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16038; }","duration":"363.26528ms","start":"2026-10-06T10:39:41.948698Z","end":"2026-10-06T10:39:42.311963Z","steps":["trace[841122135] 'agreement among raft nodes before linearized reading'  (duration: 363.062406ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.312035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.948686Z","time spent":"363.330281ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-10-06T10:39:42.312004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.947462Z","time spent":"364.537194ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-10-06T10:39:42.312183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.708027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.312238Z","caller":"traceutil/trace.go:171","msg":"trace[319285070] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16038; }","duration":"364.766508ms","start":"2026-10-06T10:39:41.947433Z","end":"2026-10-06T10:39:42.3122Z","steps":["trace[319285070] 'agreement among raft nodes before linearized reading'  (duration: 364.715667ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.312256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.947426Z","time spent":"364.825259ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "}
{"level":"warn","ts":"2026-10-06T10:39:42.312355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.198043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.312392Z","caller":"traceutil/trace.go:171","msg":"trace[1851971018] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16038; }","duration":"205.269155ms","start":"2026-10-06T10:39:42.107112Z","end":"2026-10-06T10:39:42.312381Z","steps":["trace[1851971018] 'agreement among raft nodes before linearized reading'  (duration: 205.218274ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.312447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.027003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.312466Z","caller":"traceutil/trace.go:171","msg":"trace[285139827] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16038; }","duration":"365.046473ms","start":"2026-10-06T10:39:41.947414Z","end":"2026-10-06T10:39:42.31246Z","steps":["trace[285139827] 'agreement among raft nodes before linearized reading'  (duration: 365.014603ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.312482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.947381Z","time spent":"365.097514ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-10-06T10:39:42.312583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.951505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-10-06T10:39:42.312616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.274497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.312634Z","caller":"traceutil/trace.go:171","msg":"trace[1410249089] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16038; }","duration":"208.044937ms","start":"2026-10-06T10:39:42.10458Z","end":"2026-10-06T10:39:42.312625Z","steps":["trace[1410249089] 'agreement among raft nodes before linearized reading'  (duration: 207.944515ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:39:42.312636Z","caller":"traceutil/trace.go:171","msg":"trace[1897984877] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16038; }","duration":"365.327348ms","start":"2026-10-06T10:39:41.947303Z","end":"2026-10-06T10:39:42.31263Z","steps":["trace[1897984877] 'agreement among raft nodes before linearized reading'  (duration: 365.281278ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.312675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.947288Z","time spent":"365.382529ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "}
{"level":"warn","ts":"2026-10-06T10:39:42.312813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.337773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.312845Z","caller":"traceutil/trace.go:171","msg":"trace[527619952] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16038; }","duration":"208.391023ms","start":"2026-10-06T10:39:42.104446Z","end":"2026-10-06T10:39:42.312837Z","steps":["trace[527619952] 'agreement among raft nodes before linearized reading'  (duration: 208.345152ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.312911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.575206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.312937Z","caller":"traceutil/trace.go:171","msg":"trace[348899040] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16038; }","duration":"208.633018ms","start":"2026-10-06T10:39:42.104297Z","end":"2026-10-06T10:39:42.31293Z","steps":["trace[348899040] 'agreement among raft nodes before linearized reading'  (duration: 208.599597ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.31307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.66701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-06T10:39:42.3131Z","caller":"traceutil/trace.go:171","msg":"trace[161430342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16038; }","duration":"275.719862ms","start":"2026-10-06T10:39:42.037373Z","end":"2026-10-06T10:39:42.313093Z","steps":["trace[161430342] 'agreement among raft nodes before linearized reading'  (duration: 275.67039ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.313261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.265932ms","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-10-06T10:39:42.313291Z","caller":"traceutil/trace.go:171","msg":"trace[2085199937] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16038; }","duration":"328.327052ms","start":"2026-10-06T10:39:41.984957Z","end":"2026-10-06T10:39:42.313284Z","steps":["trace[2085199937] 'agreement among raft nodes before linearized reading'  (duration: 328.242611ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.313312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.984942Z","time spent":"328.365123ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-06T10:39:42.313414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.999148ms","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-10-06T10:39:42.313458Z","caller":"traceutil/trace.go:171","msg":"trace[1391976046] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:16038; }","duration":"335.08407ms","start":"2026-10-06T10:39:41.978366Z","end":"2026-10-06T10:39:42.313451Z","steps":["trace[1391976046] 'agreement among raft nodes before linearized reading'  (duration: 334.949077ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.313477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.978342Z","time spent":"335.13051ms","remote":"127.0.0.1:57282","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":"info","ts":"2026-10-06T10:39:42.311941Z","caller":"traceutil/trace.go:171","msg":"trace[1819181798] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16038; }","duration":"364.399291ms","start":"2026-10-06T10:39:41.947533Z","end":"2026-10-06T10:39:42.311932Z","steps":["trace[1819181798] 'agreement among raft nodes before linearized reading'  (duration: 364.285119ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:39:42.313643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:39:41.947526Z","time spent":"366.108264ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-10-06T10:42:10.68119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14635}
{"level":"info","ts":"2026-10-06T10:42:10.765963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14635,"took":"81.686739ms","hash":391458797,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":31744000,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-06T10:42:10.766061Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":391458797,"revision":14635,"compact-revision":12634}
{"level":"info","ts":"2026-10-06T10:45:59.624163Z","caller":"traceutil/trace.go:171","msg":"trace[1466207156] transaction","detail":"{read_only:false; response_revision:18773; number_of_response:1; }","duration":"111.215895ms","start":"2026-10-06T10:45:59.512909Z","end":"2026-10-06T10:45:59.624125Z","steps":["trace[1466207156] 'process raft request'  (duration: 110.93443ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:46:00.096051Z","caller":"traceutil/trace.go:171","msg":"trace[422366668] transaction","detail":"{read_only:false; response_revision:18775; number_of_response:1; }","duration":"235.202939ms","start":"2026-10-06T10:45:59.860784Z","end":"2026-10-06T10:46:00.095987Z","steps":["trace[422366668] 'process raft request'  (duration: 145.400187ms)","trace[422366668] 'compare'  (duration: 89.587038ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:46:00.46822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.981046ms","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-10-06T10:46:00.468292Z","caller":"traceutil/trace.go:171","msg":"trace[506611225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18775; }","duration":"191.080528ms","start":"2026-10-06T10:46:00.277195Z","end":"2026-10-06T10:46:00.468276Z","steps":["trace[506611225] 'range keys from in-memory index tree'  (duration: 190.67556ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:46:00.46851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.862262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-svc7x\" ","response":"range_response_count:1 size:20759"}
{"level":"info","ts":"2026-10-06T10:46:00.468576Z","caller":"traceutil/trace.go:171","msg":"trace[989885545] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-svc7x; range_end:; response_count:1; response_revision:18775; }","duration":"242.933923ms","start":"2026-10-06T10:46:00.225602Z","end":"2026-10-06T10:46:00.468536Z","steps":["trace[989885545] 'range keys from in-memory index tree'  (duration: 242.174739ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:46:00.604178Z","caller":"traceutil/trace.go:171","msg":"trace[1249795310] transaction","detail":"{read_only:false; response_revision:18776; number_of_response:1; }","duration":"131.081428ms","start":"2026-10-06T10:46:00.473058Z","end":"2026-10-06T10:46:00.604139Z","steps":["trace[1249795310] 'process raft request'  (duration: 130.889745ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:46:00.700847Z","caller":"traceutil/trace.go:171","msg":"trace[1991585692] transaction","detail":"{read_only:false; response_revision:18777; number_of_response:1; }","duration":"226.396293ms","start":"2026-10-06T10:46:00.474423Z","end":"2026-10-06T10:46:00.700819Z","steps":["trace[1991585692] 'process raft request'  (duration: 198.854575ms)","trace[1991585692] 'compare'  (duration: 27.313044ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:46:00.701023Z","caller":"traceutil/trace.go:171","msg":"trace[362729949] linearizableReadLoop","detail":"{readStateIndex:19424; appliedIndex:19421; }","duration":"161.069913ms","start":"2026-10-06T10:46:00.539928Z","end":"2026-10-06T10:46:00.700998Z","steps":["trace[362729949] 'read index received'  (duration: 64.110168ms)","trace[362729949] 'applied index is now lower than readState.Index'  (duration: 96.957895ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:46:00.701074Z","caller":"traceutil/trace.go:171","msg":"trace[1259866725] transaction","detail":"{read_only:false; response_revision:18778; number_of_response:1; }","duration":"211.081605ms","start":"2026-10-06T10:46:00.489965Z","end":"2026-10-06T10:46:00.701047Z","steps":["trace[1259866725] 'process raft request'  (duration: 210.775359ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:46:00.701312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.348658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-l5q2s\" ","response":"range_response_count:1 size:22129"}
{"level":"info","ts":"2026-10-06T10:46:00.701397Z","caller":"traceutil/trace.go:171","msg":"trace[1561003379] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-l5q2s; range_end:; response_count:1; response_revision:18778; }","duration":"161.48642ms","start":"2026-10-06T10:46:00.539892Z","end":"2026-10-06T10:46:00.701379Z","steps":["trace[1561003379] 'agreement among raft nodes before linearized reading'  (duration: 161.178174ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:46:45.586145Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"eae99266654eff69","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-06T10:46:45.594078Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-06T10:46:45.594396Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-06T10:47:10.689576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17043}
{"level":"info","ts":"2026-10-06T10:47:10.797331Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17043,"took":"103.444428ms","hash":4145216192,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":33648640,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-06T10:47:10.797405Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4145216192,"revision":17043,"compact-revision":14635}
{"level":"info","ts":"2026-10-06T10:52:01.727395Z","caller":"traceutil/trace.go:171","msg":"trace[73624804] transaction","detail":"{read_only:false; response_revision:21539; number_of_response:1; }","duration":"376.009181ms","start":"2026-10-06T10:52:01.351363Z","end":"2026-10-06T10:52:01.727372Z","steps":["trace[73624804] 'process raft request'  (duration: 375.95306ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:52:01.727743Z","caller":"traceutil/trace.go:171","msg":"trace[1001318932] transaction","detail":"{read_only:false; response_revision:21538; number_of_response:1; }","duration":"376.587662ms","start":"2026-10-06T10:52:01.351118Z","end":"2026-10-06T10:52:01.727706Z","steps":["trace[1001318932] 'process raft request'  (duration: 301.699491ms)","trace[1001318932] 'compare'  (duration: 74.385572ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:52:01.728256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:52:01.351098Z","time spent":"376.724974ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:21527 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-06T10:52:01.728492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:52:01.351339Z","time spent":"376.200035ms","remote":"127.0.0.1:57362","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:21528 > 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-10-06T10:52:01.748132Z","caller":"traceutil/trace.go:171","msg":"trace[94364356] transaction","detail":"{read_only:false; response_revision:21540; number_of_response:1; }","duration":"292.886396ms","start":"2026-10-06T10:52:01.455225Z","end":"2026-10-06T10:52:01.748111Z","steps":["trace[94364356] 'process raft request'  (duration: 292.774164ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:52:02.880909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.978602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:52:02.880987Z","caller":"traceutil/trace.go:171","msg":"trace[1081478445] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:21542; }","duration":"117.116205ms","start":"2026-10-06T10:52:02.763853Z","end":"2026-10-06T10:52:02.880969Z","steps":["trace[1081478445] 'count revisions from in-memory index tree'  (duration: 116.88506ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:52:03.323102Z","caller":"traceutil/trace.go:171","msg":"trace[473295375] transaction","detail":"{read_only:false; response_revision:21545; number_of_response:1; }","duration":"156.397935ms","start":"2026-10-06T10:52:03.166671Z","end":"2026-10-06T10:52:03.323069Z","steps":["trace[473295375] 'process raft request'  (duration: 138.670311ms)","trace[473295375] 'compare'  (duration: 16.904858ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:52:10.695982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19538}
{"level":"info","ts":"2026-10-06T10:52:10.811701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19538,"took":"112.56861ms","hash":1830694706,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":29052928,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-06T10:52:10.811764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1830694706,"revision":19538,"compact-revision":17043}
{"level":"info","ts":"2026-10-06T10:52:27.713889Z","caller":"traceutil/trace.go:171","msg":"trace[1933986675] transaction","detail":"{read_only:false; response_revision:21675; number_of_response:1; }","duration":"102.798516ms","start":"2026-10-06T10:52:27.611064Z","end":"2026-10-06T10:52:27.713862Z","steps":["trace[1933986675] 'process raft request'  (duration: 102.638403ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:56:05.050914Z","caller":"traceutil/trace.go:171","msg":"trace[303505027] transaction","detail":"{read_only:false; response_revision:24048; number_of_response:1; }","duration":"147.448607ms","start":"2026-10-06T10:56:04.903425Z","end":"2026-10-06T10:56:05.050873Z","steps":["trace[303505027] 'process raft request'  (duration: 145.033931ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:56:05.40093Z","caller":"traceutil/trace.go:171","msg":"trace[1603941723] linearizableReadLoop","detail":"{readStateIndex:24865; appliedIndex:24864; }","duration":"254.089885ms","start":"2026-10-06T10:56:05.146802Z","end":"2026-10-06T10:56:05.400892Z","steps":["trace[1603941723] 'read index received'  (duration: 239.583001ms)","trace[1603941723] 'applied index is now lower than readState.Index'  (duration: 14.505584ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:56:05.400981Z","caller":"traceutil/trace.go:171","msg":"trace[1441157163] transaction","detail":"{read_only:false; response_revision:24051; number_of_response:1; }","duration":"254.469992ms","start":"2026-10-06T10:56:05.146468Z","end":"2026-10-06T10:56:05.400938Z","steps":["trace[1441157163] 'process raft request'  (duration: 239.874406ms)","trace[1441157163] 'compare'  (duration: 14.051295ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:56:05.401214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.39356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18972"}
{"level":"info","ts":"2026-10-06T10:56:05.401311Z","caller":"traceutil/trace.go:171","msg":"trace[1284980019] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24051; }","duration":"254.514853ms","start":"2026-10-06T10:56:05.146769Z","end":"2026-10-06T10:56:05.401284Z","steps":["trace[1284980019] 'agreement among raft nodes before linearized reading'  (duration: 254.224478ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:57:10.705242Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21585}
{"level":"info","ts":"2026-10-06T10:57:10.818821Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21585,"took":"109.632903ms","hash":531581883,"current-db-size-bytes":55894016,"current-db-size":"56 MB","current-db-size-in-use-bytes":42651648,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-10-06T10:57:10.818892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":531581883,"revision":21585,"compact-revision":19538}
{"level":"info","ts":"2026-10-06T10:59:36.847239Z","caller":"traceutil/trace.go:171","msg":"trace[1056091931] transaction","detail":"{read_only:false; response_revision:26148; number_of_response:1; }","duration":"201.774967ms","start":"2026-10-06T10:59:36.645441Z","end":"2026-10-06T10:59:36.847216Z","steps":["trace[1056091931] 'process raft request'  (duration: 201.634744ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:36.853008Z","caller":"traceutil/trace.go:171","msg":"trace[745584588] transaction","detail":"{read_only:false; response_revision:26149; number_of_response:1; }","duration":"132.653647ms","start":"2026-10-06T10:59:36.72034Z","end":"2026-10-06T10:59:36.852993Z","steps":["trace[745584588] 'process raft request'  (duration: 132.332141ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:36.853024Z","caller":"traceutil/trace.go:171","msg":"trace[486004946] transaction","detail":"{read_only:false; response_revision:26150; number_of_response:1; }","duration":"132.061075ms","start":"2026-10-06T10:59:36.720922Z","end":"2026-10-06T10:59:36.852983Z","steps":["trace[486004946] 'process raft request'  (duration: 131.830551ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:37.342015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.398034ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503582 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26139 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:37.342102Z","caller":"traceutil/trace.go:171","msg":"trace[401109563] transaction","detail":"{read_only:false; response_revision:26153; number_of_response:1; }","duration":"224.964243ms","start":"2026-10-06T10:59:37.117124Z","end":"2026-10-06T10:59:37.342088Z","steps":["trace[401109563] 'process raft request'  (duration: 119.421427ms)","trace[401109563] 'compare'  (duration: 105.18839ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:37.607973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.345057ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503583 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26140 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:37.608265Z","caller":"traceutil/trace.go:171","msg":"trace[394243101] linearizableReadLoop","detail":"{readStateIndex:27024; appliedIndex:27022; }","duration":"236.304367ms","start":"2026-10-06T10:59:37.371945Z","end":"2026-10-06T10:59:37.60825Z","steps":["trace[394243101] 'read index received'  (duration: 108.557252ms)","trace[394243101] 'applied index is now lower than readState.Index'  (duration: 127.746105ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:37.608327Z","caller":"traceutil/trace.go:171","msg":"trace[1540488400] transaction","detail":"{read_only:false; response_revision:26155; number_of_response:1; }","duration":"273.229112ms","start":"2026-10-06T10:59:37.335089Z","end":"2026-10-06T10:59:37.608318Z","steps":["trace[1540488400] 'process raft request'  (duration: 273.099929ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:37.608421Z","caller":"traceutil/trace.go:171","msg":"trace[1513121344] transaction","detail":"{read_only:false; response_revision:26154; number_of_response:1; }","duration":"426.718581ms","start":"2026-10-06T10:59:37.181666Z","end":"2026-10-06T10:59:37.608384Z","steps":["trace[1513121344] 'process raft request'  (duration: 298.875316ms)","trace[1513121344] 'compare'  (duration: 127.154792ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:37.608504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.556001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-06T10:59:37.608532Z","caller":"traceutil/trace.go:171","msg":"trace[1782924098] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:26155; }","duration":"236.613003ms","start":"2026-10-06T10:59:37.37191Z","end":"2026-10-06T10:59:37.608523Z","steps":["trace[1782924098] 'agreement among raft nodes before linearized reading'  (duration: 236.508851ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:37.608576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:37.181644Z","time spent":"426.846023ms","remote":"127.0.0.1:57362","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:26140 > 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-10-06T10:59:37.612828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.761938ms","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-10-06T10:59:37.612868Z","caller":"traceutil/trace.go:171","msg":"trace[1484420355] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:26156; }","duration":"150.841899ms","start":"2026-10-06T10:59:37.462018Z","end":"2026-10-06T10:59:37.61286Z","steps":["trace[1484420355] 'agreement among raft nodes before linearized reading'  (duration: 150.762767ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:38.046696Z","caller":"traceutil/trace.go:171","msg":"trace[1574233969] transaction","detail":"{read_only:false; response_revision:26159; number_of_response:1; }","duration":"126.625954ms","start":"2026-10-06T10:59:37.920042Z","end":"2026-10-06T10:59:38.046667Z","steps":["trace[1574233969] 'process raft request'  (duration: 123.521764ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:41.106352Z","caller":"traceutil/trace.go:171","msg":"trace[52226451] transaction","detail":"{read_only:false; response_revision:26187; number_of_response:1; }","duration":"235.354089ms","start":"2026-10-06T10:59:40.870967Z","end":"2026-10-06T10:59:41.106321Z","steps":["trace[52226451] 'process raft request'  (duration: 235.275038ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:41.106373Z","caller":"traceutil/trace.go:171","msg":"trace[1264784031] transaction","detail":"{read_only:false; response_revision:26186; number_of_response:1; }","duration":"237.567622ms","start":"2026-10-06T10:59:40.86877Z","end":"2026-10-06T10:59:41.106338Z","steps":["trace[1264784031] 'process raft request'  (duration: 217.597166ms)","trace[1264784031] 'compare'  (duration: 19.68044ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:41.500388Z","caller":"traceutil/trace.go:171","msg":"trace[1636282356] transaction","detail":"{read_only:false; response_revision:26189; number_of_response:1; }","duration":"139.76957ms","start":"2026-10-06T10:59:41.360588Z","end":"2026-10-06T10:59:41.500358Z","steps":["trace[1636282356] 'process raft request'  (duration: 139.595817ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:41.803452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.512744ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503655 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26177 > 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-10-06T10:59:41.803673Z","caller":"traceutil/trace.go:171","msg":"trace[2046270009] linearizableReadLoop","detail":"{readStateIndex:27061; appliedIndex:27059; }","duration":"109.838707ms","start":"2026-10-06T10:59:41.693813Z","end":"2026-10-06T10:59:41.803652Z","steps":["trace[2046270009] 'read index received'  (duration: 2.044127ms)","trace[2046270009] 'applied index is now lower than readState.Index'  (duration: 107.79338ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:41.803737Z","caller":"traceutil/trace.go:171","msg":"trace[1746522837] transaction","detail":"{read_only:false; response_revision:26191; number_of_response:1; }","duration":"180.924625ms","start":"2026-10-06T10:59:41.622772Z","end":"2026-10-06T10:59:41.803697Z","steps":["trace[1746522837] 'process raft request'  (duration: 180.788013ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:41.803778Z","caller":"traceutil/trace.go:171","msg":"trace[240748826] transaction","detail":"{read_only:false; response_revision:26190; number_of_response:1; }","duration":"183.715828ms","start":"2026-10-06T10:59:41.620043Z","end":"2026-10-06T10:59:41.803758Z","steps":["trace[240748826] 'process raft request'  (duration: 75.786696ms)","trace[240748826] 'compare'  (duration: 106.988453ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:41.804134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.310716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:419144"}
{"level":"info","ts":"2026-10-06T10:59:41.804199Z","caller":"traceutil/trace.go:171","msg":"trace[967714670] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:26191; }","duration":"110.413948ms","start":"2026-10-06T10:59:41.693766Z","end":"2026-10-06T10:59:41.80418Z","steps":["trace[967714670] 'agreement among raft nodes before linearized reading'  (duration: 109.94814ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:42.053691Z","caller":"traceutil/trace.go:171","msg":"trace[701773352] linearizableReadLoop","detail":"{readStateIndex:27062; appliedIndex:27061; }","duration":"109.423369ms","start":"2026-10-06T10:59:41.94425Z","end":"2026-10-06T10:59:42.053674Z","steps":["trace[701773352] 'read index received'  (duration: 108.897759ms)","trace[701773352] 'applied index is now lower than readState.Index'  (duration: 524.62µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:42.053894Z","caller":"traceutil/trace.go:171","msg":"trace[1466004365] transaction","detail":"{read_only:false; response_revision:26192; number_of_response:1; }","duration":"128.524729ms","start":"2026-10-06T10:59:41.92536Z","end":"2026-10-06T10:59:42.053885Z","steps":["trace[1466004365] 'process raft request'  (duration: 128.196663ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:42.05455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.273226ms","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-10-06T10:59:42.054675Z","caller":"traceutil/trace.go:171","msg":"trace[1132274263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26192; }","duration":"110.445118ms","start":"2026-10-06T10:59:41.944206Z","end":"2026-10-06T10:59:42.054651Z","steps":["trace[1132274263] 'agreement among raft nodes before linearized reading'  (duration: 109.585842ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:42.221163Z","caller":"traceutil/trace.go:171","msg":"trace[303100018] transaction","detail":"{read_only:false; response_revision:26193; number_of_response:1; }","duration":"161.898747ms","start":"2026-10-06T10:59:42.059233Z","end":"2026-10-06T10:59:42.221132Z","steps":["trace[303100018] 'process raft request'  (duration: 135.184434ms)","trace[303100018] 'compare'  (duration: 26.289705ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:42.590394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.863469ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503666 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26183 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:42.590498Z","caller":"traceutil/trace.go:171","msg":"trace[1730926550] transaction","detail":"{read_only:false; response_revision:26196; number_of_response:1; }","duration":"283.004826ms","start":"2026-10-06T10:59:42.307473Z","end":"2026-10-06T10:59:42.590478Z","steps":["trace[1730926550] 'process raft request'  (duration: 97.967054ms)","trace[1730926550] 'compare'  (duration: 184.677225ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:42.790874Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000069bc.wal"}
{"level":"info","ts":"2026-10-06T10:59:42.791985Z","caller":"traceutil/trace.go:171","msg":"trace[115456483] linearizableReadLoop","detail":"{readStateIndex:27067; appliedIndex:27065; }","duration":"417.368006ms","start":"2026-10-06T10:59:42.374591Z","end":"2026-10-06T10:59:42.791959Z","steps":["trace[115456483] 'read index received'  (duration: 30.714718ms)","trace[115456483] 'applied index is now lower than readState.Index'  (duration: 386.651838ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:42.792431Z","caller":"traceutil/trace.go:171","msg":"trace[2030790768] transaction","detail":"{read_only:false; response_revision:26197; number_of_response:1; }","duration":"478.914864ms","start":"2026-10-06T10:59:42.313476Z","end":"2026-10-06T10:59:42.792391Z","steps":["trace[2030790768] 'process raft request'  (duration: 477.906264ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:42.792498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.866415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-06T10:59:42.792536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.910926ms","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-10-06T10:59:42.792595Z","caller":"traceutil/trace.go:171","msg":"trace[414071330] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:26197; }","duration":"410.018208ms","start":"2026-10-06T10:59:42.382553Z","end":"2026-10-06T10:59:42.792572Z","steps":["trace[414071330] 'agreement among raft nodes before linearized reading'  (duration: 409.834275ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:42.792608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:42.313447Z","time spent":"479.065937ms","remote":"127.0.0.1:60434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419202,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:25605 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:419134 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"info","ts":"2026-10-06T10:59:42.792632Z","caller":"traceutil/trace.go:171","msg":"trace[1561227482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26197; }","duration":"418.064659ms","start":"2026-10-06T10:59:42.374541Z","end":"2026-10-06T10:59:42.792605Z","steps":["trace[1561227482] 'agreement among raft nodes before linearized reading'  (duration: 417.747803ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:42.792645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:42.38253Z","time spent":"410.104289ms","remote":"127.0.0.1:52586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "}
{"level":"warn","ts":"2026-10-06T10:59:42.792676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:42.374518Z","time spent":"418.14938ms","remote":"127.0.0.1:57362","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-10-06T10:59:42.793647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.522836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-10-06T10:59:42.793701Z","caller":"traceutil/trace.go:171","msg":"trace[1678444615] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26197; }","duration":"165.620848ms","start":"2026-10-06T10:59:42.628068Z","end":"2026-10-06T10:59:42.793689Z","steps":["trace[1678444615] 'agreement among raft nodes before linearized reading'  (duration: 164.327904ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:46.376427Z","caller":"traceutil/trace.go:171","msg":"trace[2069161231] linearizableReadLoop","detail":"{readStateIndex:27095; appliedIndex:27094; }","duration":"103.816374ms","start":"2026-10-06T10:59:46.272583Z","end":"2026-10-06T10:59:46.3764Z","steps":["trace[2069161231] 'read index received'  (duration: 103.743243ms)","trace[2069161231] 'applied index is now lower than readState.Index'  (duration: 71.771µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:46.376627Z","caller":"traceutil/trace.go:171","msg":"trace[1289490972] transaction","detail":"{read_only:false; response_revision:26224; number_of_response:1; }","duration":"134.755316ms","start":"2026-10-06T10:59:46.241824Z","end":"2026-10-06T10:59:46.37658Z","steps":["trace[1289490972] 'process raft request'  (duration: 134.41622ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:46.376679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.067178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:46.376794Z","caller":"traceutil/trace.go:171","msg":"trace[1704859126] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:26224; }","duration":"104.217191ms","start":"2026-10-06T10:59:46.272527Z","end":"2026-10-06T10:59:46.376744Z","steps":["trace[1704859126] 'agreement among raft nodes before linearized reading'  (duration: 104.032118ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:46.57081Z","caller":"traceutil/trace.go:171","msg":"trace[1367883441] linearizableReadLoop","detail":"{readStateIndex:27096; appliedIndex:27095; }","duration":"194.203214ms","start":"2026-10-06T10:59:46.376585Z","end":"2026-10-06T10:59:46.570788Z","steps":["trace[1367883441] 'read index received'  (duration: 193.97262ms)","trace[1367883441] 'applied index is now lower than readState.Index'  (duration: 229.424µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:46.571137Z","caller":"traceutil/trace.go:171","msg":"trace[1775988918] transaction","detail":"{read_only:false; response_revision:26225; number_of_response:1; }","duration":"259.887522ms","start":"2026-10-06T10:59:46.311234Z","end":"2026-10-06T10:59:46.571122Z","steps":["trace[1775988918] 'process raft request'  (duration: 259.353971ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:46.571338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.231701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:46.571418Z","caller":"traceutil/trace.go:171","msg":"trace[451402195] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:26225; }","duration":"181.363974ms","start":"2026-10-06T10:59:46.390035Z","end":"2026-10-06T10:59:46.571399Z","steps":["trace[451402195] 'agreement among raft nodes before linearized reading'  (duration: 181.18969ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:46.571562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.866054ms","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-10-06T10:59:46.571784Z","caller":"traceutil/trace.go:171","msg":"trace[225329012] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26225; }","duration":"266.157509ms","start":"2026-10-06T10:59:46.305615Z","end":"2026-10-06T10:59:46.571772Z","steps":["trace[225329012] 'agreement among raft nodes before linearized reading'  (duration: 265.853294ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:46.571927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.723925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:46.572046Z","caller":"traceutil/trace.go:171","msg":"trace[391219794] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26225; }","duration":"169.948989ms","start":"2026-10-06T10:59:46.402072Z","end":"2026-10-06T10:59:46.572021Z","steps":["trace[391219794] 'agreement among raft nodes before linearized reading'  (duration: 169.4774ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:46.726973Z","caller":"traceutil/trace.go:171","msg":"trace[832478414] transaction","detail":"{read_only:false; response_revision:26227; number_of_response:1; }","duration":"119.461127ms","start":"2026-10-06T10:59:46.607476Z","end":"2026-10-06T10:59:46.726937Z","steps":["trace[832478414] 'process raft request'  (duration: 100.677404ms)","trace[832478414] 'compare'  (duration: 18.6104ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:47.167471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.143698ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503746 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26215 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:47.167571Z","caller":"traceutil/trace.go:171","msg":"trace[307286352] transaction","detail":"{read_only:false; response_revision:26229; number_of_response:1; }","duration":"225.565955ms","start":"2026-10-06T10:59:46.941983Z","end":"2026-10-06T10:59:47.167549Z","steps":["trace[307286352] 'process raft request'  (duration: 69.251933ms)","trace[307286352] 'compare'  (duration: 155.65415ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:47.333079Z","caller":"traceutil/trace.go:171","msg":"trace[1032960772] transaction","detail":"{read_only:false; response_revision:26232; number_of_response:1; }","duration":"201.921771ms","start":"2026-10-06T10:59:47.131135Z","end":"2026-10-06T10:59:47.333056Z","steps":["trace[1032960772] 'process raft request'  (duration: 201.85943ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:47.333194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.54189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:47.333229Z","caller":"traceutil/trace.go:171","msg":"trace[294332203] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:26232; }","duration":"296.645822ms","start":"2026-10-06T10:59:47.036571Z","end":"2026-10-06T10:59:47.333217Z","steps":["trace[294332203] 'agreement among raft nodes before linearized reading'  (duration: 296.566561ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:47.333326Z","caller":"traceutil/trace.go:171","msg":"trace[36637395] transaction","detail":"{read_only:false; response_revision:26231; number_of_response:1; }","duration":"202.808717ms","start":"2026-10-06T10:59:47.130507Z","end":"2026-10-06T10:59:47.333315Z","steps":["trace[36637395] 'process raft request'  (duration: 202.43849ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:47.333098Z","caller":"traceutil/trace.go:171","msg":"trace[1357000687] linearizableReadLoop","detail":"{readStateIndex:27101; appliedIndex:27100; }","duration":"296.442529ms","start":"2026-10-06T10:59:47.036632Z","end":"2026-10-06T10:59:47.333075Z","steps":["trace[1357000687] 'read index received'  (duration: 276.82367ms)","trace[1357000687] 'applied index is now lower than readState.Index'  (duration: 19.616919ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:47.333396Z","caller":"traceutil/trace.go:171","msg":"trace[1559926140] transaction","detail":"{read_only:false; response_revision:26230; number_of_response:1; }","duration":"388.768578ms","start":"2026-10-06T10:59:46.944616Z","end":"2026-10-06T10:59:47.333385Z","steps":["trace[1559926140] 'process raft request'  (duration: 368.756211ms)","trace[1559926140] 'compare'  (duration: 19.423825ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:47.333464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:46.944584Z","time spent":"388.833458ms","remote":"127.0.0.1:57362","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:26148 > 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-10-06T10:59:47.333505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.39259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:47.333555Z","caller":"traceutil/trace.go:171","msg":"trace[1016343498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26232; }","duration":"295.479591ms","start":"2026-10-06T10:59:47.038063Z","end":"2026-10-06T10:59:47.333542Z","steps":["trace[1016343498] 'agreement among raft nodes before linearized reading'  (duration: 295.40394ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:47.33376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.370678ms","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-10-06T10:59:47.333811Z","caller":"traceutil/trace.go:171","msg":"trace[1394824120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26232; }","duration":"127.470039ms","start":"2026-10-06T10:59:47.206327Z","end":"2026-10-06T10:59:47.333797Z","steps":["trace[1394824120] 'agreement among raft nodes before linearized reading'  (duration: 127.322976ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:47.690711Z","caller":"traceutil/trace.go:171","msg":"trace[363826931] transaction","detail":"{read_only:false; response_revision:26234; number_of_response:1; }","duration":"161.235904ms","start":"2026-10-06T10:59:47.529452Z","end":"2026-10-06T10:59:47.690688Z","steps":["trace[363826931] 'process raft request'  (duration: 161.068471ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:48.160385Z","caller":"traceutil/trace.go:171","msg":"trace[855144093] transaction","detail":"{read_only:false; response_revision:26235; number_of_response:1; }","duration":"336.099446ms","start":"2026-10-06T10:59:47.824252Z","end":"2026-10-06T10:59:48.160352Z","steps":["trace[855144093] 'process raft request'  (duration: 335.936133ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:48.160563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:47.824225Z","time spent":"336.245448ms","remote":"127.0.0.1:57362","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:26222 > 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-10-06T10:59:48.182219Z","caller":"traceutil/trace.go:171","msg":"trace[316406198] linearizableReadLoop","detail":"{readStateIndex:27107; appliedIndex:27105; }","duration":"189.841313ms","start":"2026-10-06T10:59:47.992358Z","end":"2026-10-06T10:59:48.182199Z","steps":["trace[316406198] 'read index received'  (duration: 167.875169ms)","trace[316406198] 'applied index is now lower than readState.Index'  (duration: 21.965154ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:48.182255Z","caller":"traceutil/trace.go:171","msg":"trace[212725676] transaction","detail":"{read_only:false; response_revision:26236; number_of_response:1; }","duration":"357.809425ms","start":"2026-10-06T10:59:47.824426Z","end":"2026-10-06T10:59:48.182235Z","steps":["trace[212725676] 'process raft request'  (duration: 357.608331ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:48.182283Z","caller":"traceutil/trace.go:171","msg":"trace[1484097693] transaction","detail":"{read_only:false; response_revision:26237; number_of_response:1; }","duration":"111.280444ms","start":"2026-10-06T10:59:48.070978Z","end":"2026-10-06T10:59:48.182259Z","steps":["trace[1484097693] 'process raft request'  (duration: 111.182893ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:48.18234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:47.824397Z","time spent":"357.895826ms","remote":"127.0.0.1:57362","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:26221 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-06T10:59:48.182416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.055698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-10-06T10:59:48.182449Z","caller":"traceutil/trace.go:171","msg":"trace[1842658744] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:26237; }","duration":"190.16086ms","start":"2026-10-06T10:59:47.992278Z","end":"2026-10-06T10:59:48.182439Z","steps":["trace[1842658744] 'agreement among raft nodes before linearized reading'  (duration: 190.030627ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:48.73612Z","caller":"traceutil/trace.go:171","msg":"trace[1262036047] linearizableReadLoop","detail":"{readStateIndex:27110; appliedIndex:27109; }","duration":"150.159186ms","start":"2026-10-06T10:59:48.585929Z","end":"2026-10-06T10:59:48.736088Z","steps":["trace[1262036047] 'read index received'  (duration: 145.532159ms)","trace[1262036047] 'applied index is now lower than readState.Index'  (duration: 4.625787ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:48.736187Z","caller":"traceutil/trace.go:171","msg":"trace[1389478243] transaction","detail":"{read_only:false; response_revision:26239; number_of_response:1; }","duration":"158.724306ms","start":"2026-10-06T10:59:48.577426Z","end":"2026-10-06T10:59:48.73615Z","steps":["trace[1389478243] 'process raft request'  (duration: 154.09995ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:48.736339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.40143ms","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-10-06T10:59:48.736379Z","caller":"traceutil/trace.go:171","msg":"trace[1582200324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26239; }","duration":"150.497502ms","start":"2026-10-06T10:59:48.585869Z","end":"2026-10-06T10:59:48.736366Z","steps":["trace[1582200324] 'agreement among raft nodes before linearized reading'  (duration: 150.325199ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:49.070046Z","caller":"traceutil/trace.go:171","msg":"trace[1521050254] linearizableReadLoop","detail":"{readStateIndex:27112; appliedIndex:27111; }","duration":"209.554914ms","start":"2026-10-06T10:59:48.860465Z","end":"2026-10-06T10:59:49.07002Z","steps":["trace[1521050254] 'read index received'  (duration: 201.363559ms)","trace[1521050254] 'applied index is now lower than readState.Index'  (duration: 8.190005ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:49.07018Z","caller":"traceutil/trace.go:171","msg":"trace[246636068] transaction","detail":"{read_only:false; response_revision:26241; number_of_response:1; }","duration":"329.589834ms","start":"2026-10-06T10:59:48.74056Z","end":"2026-10-06T10:59:49.07015Z","steps":["trace[246636068] 'process raft request'  (duration: 321.230287ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:49.070299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.814769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-10-06T10:59:49.070335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:48.740536Z","time spent":"329.714286ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26226 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-06T10:59:49.070345Z","caller":"traceutil/trace.go:171","msg":"trace[541252457] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26241; }","duration":"209.90803ms","start":"2026-10-06T10:59:48.860421Z","end":"2026-10-06T10:59:49.070329Z","steps":["trace[541252457] 'agreement among raft nodes before linearized reading'  (duration: 209.752577ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:49.301799Z","caller":"traceutil/trace.go:171","msg":"trace[1233583569] transaction","detail":"{read_only:false; response_revision:26243; number_of_response:1; }","duration":"130.211001ms","start":"2026-10-06T10:59:49.171562Z","end":"2026-10-06T10:59:49.301773Z","steps":["trace[1233583569] 'process raft request'  (duration: 104.66639ms)","trace[1233583569] 'compare'  (duration: 25.237595ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:49.577711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.174713ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503776 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26231 > 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-10-06T10:59:49.577806Z","caller":"traceutil/trace.go:171","msg":"trace[1610053397] transaction","detail":"{read_only:false; response_revision:26244; number_of_response:1; }","duration":"238.072731ms","start":"2026-10-06T10:59:49.339715Z","end":"2026-10-06T10:59:49.577788Z","steps":["trace[1610053397] 'process raft request'  (duration: 101.736835ms)","trace[1610053397] 'compare'  (duration: 136.048931ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:49.896549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.758747ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503777 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26232 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:49.896807Z","caller":"traceutil/trace.go:171","msg":"trace[1298533182] transaction","detail":"{read_only:false; response_revision:26245; number_of_response:1; }","duration":"556.650287ms","start":"2026-10-06T10:59:49.340128Z","end":"2026-10-06T10:59:49.896778Z","steps":["trace[1298533182] 'process raft request'  (duration: 387.540383ms)","trace[1298533182] 'compare'  (duration: 168.313028ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:49.896922Z","caller":"traceutil/trace.go:171","msg":"trace[1581439223] transaction","detail":"{read_only:false; response_revision:26246; number_of_response:1; }","duration":"472.456563ms","start":"2026-10-06T10:59:49.424424Z","end":"2026-10-06T10:59:49.896881Z","steps":["trace[1581439223] 'process raft request'  (duration: 472.250389ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:49.896974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:49.340113Z","time spent":"556.77871ms","remote":"127.0.0.1:57362","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:26232 > 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-10-06T10:59:49.897059Z","caller":"traceutil/trace.go:171","msg":"trace[1810516959] linearizableReadLoop","detail":"{readStateIndex:27116; appliedIndex:27114; }","duration":"549.026153ms","start":"2026-10-06T10:59:49.348003Z","end":"2026-10-06T10:59:49.89703Z","steps":["trace[1810516959] 'read index received'  (duration: 93.408718ms)","trace[1810516959] 'applied index is now lower than readState.Index'  (duration: 455.614095ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:49.89711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:49.424406Z","time spent":"472.603735ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:26212 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-06T10:59:50.137051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.23646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503779 > lease_revoke:<id:7f69a110ae7215e2>","response":"size:29"}
{"level":"info","ts":"2026-10-06T10:59:50.13718Z","caller":"traceutil/trace.go:171","msg":"trace[1022997010] linearizableReadLoop","detail":"{readStateIndex:27118; appliedIndex:27117; }","duration":"240.032388ms","start":"2026-10-06T10:59:49.897123Z","end":"2026-10-06T10:59:50.137156Z","steps":["trace[1022997010] 'read index received'  (duration: 63.911µs)","trace[1022997010] 'applied index is now lower than readState.Index'  (duration: 239.966657ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:50.1373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.279155ms","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-10-06T10:59:50.13737Z","caller":"traceutil/trace.go:171","msg":"trace[603901044] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26246; }","duration":"789.399588ms","start":"2026-10-06T10:59:49.347953Z","end":"2026-10-06T10:59:50.137353Z","steps":["trace[603901044] 'agreement among raft nodes before linearized reading'  (duration: 549.217007ms)","trace[603901044] 'range keys from in-memory index tree'  (duration: 239.988907ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:50.137416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:49.347939Z","time spent":"789.461958ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-06T10:59:50.137579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.749743ms","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-10-06T10:59:50.137726Z","caller":"traceutil/trace.go:171","msg":"trace[695825059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26246; }","duration":"442.951086ms","start":"2026-10-06T10:59:49.694756Z","end":"2026-10-06T10:59:50.137707Z","steps":["trace[695825059] 'agreement among raft nodes before linearized reading'  (duration: 442.61271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:50.137775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:49.694733Z","time spent":"443.029788ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-10-06T10:59:50.426814Z","caller":"traceutil/trace.go:171","msg":"trace[687963054] linearizableReadLoop","detail":"{readStateIndex:27123; appliedIndex:27122; }","duration":"163.243731ms","start":"2026-10-06T10:59:50.26337Z","end":"2026-10-06T10:59:50.426614Z","steps":["trace[687963054] 'read index received'  (duration: 161.163412ms)","trace[687963054] 'applied index is now lower than readState.Index'  (duration: 2.078949ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:50.426995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.608799ms","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-10-06T10:59:50.427111Z","caller":"traceutil/trace.go:171","msg":"trace[1995266581] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26251; }","duration":"163.792352ms","start":"2026-10-06T10:59:50.26331Z","end":"2026-10-06T10:59:50.427102Z","steps":["trace[1995266581] 'agreement among raft nodes before linearized reading'  (duration: 163.610789ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:50.427291Z","caller":"traceutil/trace.go:171","msg":"trace[871843675] transaction","detail":"{read_only:false; response_revision:26251; number_of_response:1; }","duration":"239.13515ms","start":"2026-10-06T10:59:50.188129Z","end":"2026-10-06T10:59:50.427264Z","steps":["trace[871843675] 'process raft request'  (duration: 236.488291ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:50.733483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.179697ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503794 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26238 > 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-10-06T10:59:50.733585Z","caller":"traceutil/trace.go:171","msg":"trace[415336202] linearizableReadLoop","detail":"{readStateIndex:27124; appliedIndex:27123; }","duration":"182.462034ms","start":"2026-10-06T10:59:50.551107Z","end":"2026-10-06T10:59:50.733569Z","steps":["trace[415336202] 'read index received'  (duration: 41.020263ms)","trace[415336202] 'applied index is now lower than readState.Index'  (duration: 141.440561ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:50.733666Z","caller":"traceutil/trace.go:171","msg":"trace[1319539849] transaction","detail":"{read_only:false; response_revision:26252; number_of_response:1; }","duration":"244.099765ms","start":"2026-10-06T10:59:50.489556Z","end":"2026-10-06T10:59:50.733655Z","steps":["trace[1319539849] 'process raft request'  (duration: 102.659013ms)","trace[1319539849] 'compare'  (duration: 140.746939ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:50.733821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.682679ms","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-10-06T10:59:50.73396Z","caller":"traceutil/trace.go:171","msg":"trace[471120958] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26252; }","duration":"182.866872ms","start":"2026-10-06T10:59:50.551068Z","end":"2026-10-06T10:59:50.733935Z","steps":["trace[471120958] 'agreement among raft nodes before linearized reading'  (duration: 182.654777ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:51.025642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.154235ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503798 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:26239 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:51.02597Z","caller":"traceutil/trace.go:171","msg":"trace[1690639001] transaction","detail":"{read_only:false; response_revision:26254; number_of_response:1; }","duration":"275.344211ms","start":"2026-10-06T10:59:50.750608Z","end":"2026-10-06T10:59:51.025952Z","steps":["trace[1690639001] 'process raft request'  (duration: 275.198579ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:51.026106Z","caller":"traceutil/trace.go:171","msg":"trace[359417525] linearizableReadLoop","detail":"{readStateIndex:27125; appliedIndex:27124; }","duration":"281.984927ms","start":"2026-10-06T10:59:50.744063Z","end":"2026-10-06T10:59:51.026048Z","steps":["trace[359417525] 'read index received'  (duration: 130.256952ms)","trace[359417525] 'applied index is now lower than readState.Index'  (duration: 151.725225ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:51.026285Z","caller":"traceutil/trace.go:171","msg":"trace[1371395282] transaction","detail":"{read_only:false; response_revision:26253; number_of_response:1; }","duration":"285.129547ms","start":"2026-10-06T10:59:50.741127Z","end":"2026-10-06T10:59:51.026257Z","steps":["trace[1371395282] 'process raft request'  (duration: 133.2778ms)","trace[1371395282] 'compare'  (duration: 150.889679ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:51.026569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.494907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-10-06T10:59:51.026622Z","caller":"traceutil/trace.go:171","msg":"trace[883131919] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26254; }","duration":"282.599309ms","start":"2026-10-06T10:59:50.744013Z","end":"2026-10-06T10:59:51.026612Z","steps":["trace[883131919] 'agreement among raft nodes before linearized reading'  (duration: 282.405375ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:51.253382Z","caller":"traceutil/trace.go:171","msg":"trace[1948835136] linearizableReadLoop","detail":"{readStateIndex:27127; appliedIndex:27126; }","duration":"167.465182ms","start":"2026-10-06T10:59:51.085895Z","end":"2026-10-06T10:59:51.25336Z","steps":["trace[1948835136] 'read index received'  (duration: 81.306481ms)","trace[1948835136] 'applied index is now lower than readState.Index'  (duration: 86.157701ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:51.253569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.666596ms","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-10-06T10:59:51.253607Z","caller":"traceutil/trace.go:171","msg":"trace[1371730857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26255; }","duration":"167.783598ms","start":"2026-10-06T10:59:51.085811Z","end":"2026-10-06T10:59:51.253595Z","steps":["trace[1371730857] 'agreement among raft nodes before linearized reading'  (duration: 167.634295ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:51.253603Z","caller":"traceutil/trace.go:171","msg":"trace[662104598] transaction","detail":"{read_only:false; response_revision:26255; number_of_response:1; }","duration":"174.532414ms","start":"2026-10-06T10:59:51.079043Z","end":"2026-10-06T10:59:51.253575Z","steps":["trace[662104598] 'process raft request'  (duration: 88.161869ms)","trace[662104598] 'compare'  (duration: 86.014889ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:51.619194Z","caller":"traceutil/trace.go:171","msg":"trace[1576446542] transaction","detail":"{read_only:false; response_revision:26256; number_of_response:1; }","duration":"361.159987ms","start":"2026-10-06T10:59:51.257989Z","end":"2026-10-06T10:59:51.619149Z","steps":["trace[1576446542] 'process raft request'  (duration: 359.72919ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:51.619355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:51.257968Z","time spent":"361.308051ms","remote":"127.0.0.1:57362","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:26242 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-06T10:59:51.626963Z","caller":"traceutil/trace.go:171","msg":"trace[83501427] linearizableReadLoop","detail":"{readStateIndex:27129; appliedIndex:27127; }","duration":"296.242565ms","start":"2026-10-06T10:59:51.330699Z","end":"2026-10-06T10:59:51.626942Z","steps":["trace[83501427] 'read index received'  (duration: 286.975451ms)","trace[83501427] 'applied index is now lower than readState.Index'  (duration: 9.266314ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:51.62705Z","caller":"traceutil/trace.go:171","msg":"trace[213023241] transaction","detail":"{read_only:false; response_revision:26257; number_of_response:1; }","duration":"320.642335ms","start":"2026-10-06T10:59:51.306375Z","end":"2026-10-06T10:59:51.627017Z","steps":["trace[213023241] 'process raft request'  (duration: 320.37047ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:51.627232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.52956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-06T10:59:51.627218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.053617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:51.627296Z","caller":"traceutil/trace.go:171","msg":"trace[270686516] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:26258; }","duration":"296.674933ms","start":"2026-10-06T10:59:51.330606Z","end":"2026-10-06T10:59:51.627281Z","steps":["trace[270686516] 'agreement among raft nodes before linearized reading'  (duration: 296.566741ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:51.627309Z","caller":"traceutil/trace.go:171","msg":"trace[2749939] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:26258; }","duration":"233.165969ms","start":"2026-10-06T10:59:51.394125Z","end":"2026-10-06T10:59:51.627291Z","steps":["trace[2749939] 'agreement among raft nodes before linearized reading'  (duration: 233.019316ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:51.627238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.183138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-06T10:59:51.627323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:51.306355Z","time spent":"320.771327ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26243 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-06T10:59:51.62741Z","caller":"traceutil/trace.go:171","msg":"trace[415445932] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:26258; }","duration":"191.371781ms","start":"2026-10-06T10:59:51.436003Z","end":"2026-10-06T10:59:51.627374Z","steps":["trace[415445932] 'agreement among raft nodes before linearized reading'  (duration: 191.183168ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:51.920119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.882181ms","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":"info","ts":"2026-10-06T10:59:51.92024Z","caller":"traceutil/trace.go:171","msg":"trace[1889585035] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:26258; }","duration":"159.063814ms","start":"2026-10-06T10:59:51.761148Z","end":"2026-10-06T10:59:51.920212Z","steps":["trace[1889585035] 'count revisions from in-memory index tree'  (duration: 158.794089ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:52.175562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.602468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T10:59:52.175654Z","caller":"traceutil/trace.go:171","msg":"trace[2132583069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26259; }","duration":"138.747691ms","start":"2026-10-06T10:59:52.036884Z","end":"2026-10-06T10:59:52.175631Z","steps":["trace[2132583069] 'range keys from in-memory index tree'  (duration: 138.465335ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:52.400579Z","caller":"traceutil/trace.go:171","msg":"trace[609569582] transaction","detail":"{read_only:false; response_revision:26260; number_of_response:1; }","duration":"215.609117ms","start":"2026-10-06T10:59:52.184942Z","end":"2026-10-06T10:59:52.400552Z","steps":["trace[609569582] 'process raft request'  (duration: 215.459004ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:52.726135Z","caller":"traceutil/trace.go:171","msg":"trace[1997137000] transaction","detail":"{read_only:false; response_revision:26262; number_of_response:1; }","duration":"539.055196ms","start":"2026-10-06T10:59:52.187057Z","end":"2026-10-06T10:59:52.726113Z","steps":["trace[1997137000] 'process raft request'  (duration: 538.967924ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:52.726216Z","caller":"traceutil/trace.go:171","msg":"trace[1755201337] transaction","detail":"{read_only:false; response_revision:26261; number_of_response:1; }","duration":"541.020802ms","start":"2026-10-06T10:59:52.185145Z","end":"2026-10-06T10:59:52.726166Z","steps":["trace[1755201337] 'process raft request'  (duration: 472.203076ms)","trace[1755201337] 'compare'  (duration: 68.226795ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:52.726275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:52.187027Z","time spent":"539.174079ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26248 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-06T10:59:52.726403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:52.185133Z","time spent":"541.164905ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26247 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-06T10:59:52.726677Z","caller":"traceutil/trace.go:171","msg":"trace[1853713890] transaction","detail":"{read_only:false; response_revision:26263; number_of_response:1; }","duration":"512.113989ms","start":"2026-10-06T10:59:52.214531Z","end":"2026-10-06T10:59:52.726645Z","steps":["trace[1853713890] 'process raft request'  (duration: 511.549318ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:52.726841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:52.214515Z","time spent":"512.236971ms","remote":"127.0.0.1:57362","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:26250 > 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-10-06T10:59:52.817819Z","caller":"traceutil/trace.go:171","msg":"trace[1060603853] linearizableReadLoop","detail":"{readStateIndex:27136; appliedIndex:27132; }","duration":"339.451329ms","start":"2026-10-06T10:59:52.478349Z","end":"2026-10-06T10:59:52.817801Z","steps":["trace[1060603853] 'read index received'  (duration: 182.450454ms)","trace[1060603853] 'applied index is now lower than readState.Index'  (duration: 157.000105ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:52.818041Z","caller":"traceutil/trace.go:171","msg":"trace[124906258] transaction","detail":"{read_only:false; response_revision:26264; number_of_response:1; }","duration":"386.117767ms","start":"2026-10-06T10:59:52.431914Z","end":"2026-10-06T10:59:52.818032Z","steps":["trace[124906258] 'process raft request'  (duration: 385.76005ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:52.818118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:52.431892Z","time spent":"386.173759ms","remote":"127.0.0.1:57362","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:26251 > 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-10-06T10:59:52.818253Z","caller":"traceutil/trace.go:171","msg":"trace[1580478359] transaction","detail":"{read_only:false; response_revision:26265; number_of_response:1; }","duration":"197.286103ms","start":"2026-10-06T10:59:52.62096Z","end":"2026-10-06T10:59:52.818247Z","steps":["trace[1580478359] 'process raft request'  (duration: 196.809764ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:52.818394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.041081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-06T10:59:52.818425Z","caller":"traceutil/trace.go:171","msg":"trace[1556639725] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:26265; }","duration":"340.104282ms","start":"2026-10-06T10:59:52.478314Z","end":"2026-10-06T10:59:52.818418Z","steps":["trace[1556639725] 'agreement among raft nodes before linearized reading'  (duration: 340.03556ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:52.818446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:52.478302Z","time spent":"340.138623ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":19,"response size":31,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-10-06T10:59:53.027947Z","caller":"traceutil/trace.go:171","msg":"trace[220411640] linearizableReadLoop","detail":"{readStateIndex:27138; appliedIndex:27137; }","duration":"172.312813ms","start":"2026-10-06T10:59:52.855599Z","end":"2026-10-06T10:59:53.027912Z","steps":["trace[220411640] 'read index received'  (duration: 138.777541ms)","trace[220411640] 'applied index is now lower than readState.Index'  (duration: 33.533992ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:53.027975Z","caller":"traceutil/trace.go:171","msg":"trace[960375085] transaction","detail":"{read_only:false; response_revision:26266; number_of_response:1; }","duration":"204.511539ms","start":"2026-10-06T10:59:52.823437Z","end":"2026-10-06T10:59:53.027948Z","steps":["trace[960375085] 'process raft request'  (duration: 171.002149ms)","trace[960375085] 'compare'  (duration: 33.076912ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:53.028219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.590979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-10-06T10:59:53.028328Z","caller":"traceutil/trace.go:171","msg":"trace[392976626] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26266; }","duration":"172.746132ms","start":"2026-10-06T10:59:52.855557Z","end":"2026-10-06T10:59:53.028303Z","steps":["trace[392976626] 'agreement among raft nodes before linearized reading'  (duration: 172.478496ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:53.254828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.157165ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244503836 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:26159 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T10:59:53.254974Z","caller":"traceutil/trace.go:171","msg":"trace[156801697] transaction","detail":"{read_only:false; response_revision:26269; number_of_response:1; }","duration":"142.91987ms","start":"2026-10-06T10:59:53.112032Z","end":"2026-10-06T10:59:53.254952Z","steps":["trace[156801697] 'process raft request'  (duration: 26.541331ms)","trace[156801697] 'compare'  (duration: 115.996962ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:57.775256Z","caller":"traceutil/trace.go:171","msg":"trace[1772709241] transaction","detail":"{read_only:false; response_revision:26303; number_of_response:1; }","duration":"126.823867ms","start":"2026-10-06T10:59:57.648398Z","end":"2026-10-06T10:59:57.775222Z","steps":["trace[1772709241] 'process raft request'  (duration: 125.610934ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:57.775692Z","caller":"traceutil/trace.go:171","msg":"trace[1149219566] linearizableReadLoop","detail":"{readStateIndex:27177; appliedIndex:27175; }","duration":"123.607066ms","start":"2026-10-06T10:59:57.652062Z","end":"2026-10-06T10:59:57.775669Z","steps":["trace[1149219566] 'read index received'  (duration: 122.097858ms)","trace[1149219566] 'applied index is now lower than readState.Index'  (duration: 1.508278ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:57.775804Z","caller":"traceutil/trace.go:171","msg":"trace[680158999] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"124.518853ms","start":"2026-10-06T10:59:57.65126Z","end":"2026-10-06T10:59:57.775779Z","steps":["trace[680158999] 'process raft request'  (duration: 124.289519ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T10:59:57.775917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.83863ms","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-10-06T10:59:57.775965Z","caller":"traceutil/trace.go:171","msg":"trace[1488155782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26304; }","duration":"123.941862ms","start":"2026-10-06T10:59:57.65201Z","end":"2026-10-06T10:59:57.775952Z","steps":["trace[1488155782] 'agreement among raft nodes before linearized reading'  (duration: 123.766399ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:58.25844Z","caller":"traceutil/trace.go:171","msg":"trace[1646656676] linearizableReadLoop","detail":"{readStateIndex:27179; appliedIndex:27178; }","duration":"149.117537ms","start":"2026-10-06T10:59:58.109292Z","end":"2026-10-06T10:59:58.25841Z","steps":["trace[1646656676] 'read index received'  (duration: 61.832344ms)","trace[1646656676] 'applied index is now lower than readState.Index'  (duration: 87.283893ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T10:59:58.258591Z","caller":"traceutil/trace.go:171","msg":"trace[737595067] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"318.338101ms","start":"2026-10-06T10:59:57.940236Z","end":"2026-10-06T10:59:58.258574Z","steps":["trace[737595067] 'process raft request'  (duration: 230.852454ms)","trace[737595067] 'compare'  (duration: 87.046508ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T10:59:58.258798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.656823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-06T10:59:58.258829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.524015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-06T10:59:58.258902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:59:57.940213Z","time spent":"318.542786ms","remote":"127.0.0.1:57362","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:26291 > 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-10-06T10:59:58.258918Z","caller":"traceutil/trace.go:171","msg":"trace[625865522] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:26306; }","duration":"102.828985ms","start":"2026-10-06T10:59:58.156068Z","end":"2026-10-06T10:59:58.258897Z","steps":["trace[625865522] 'agreement among raft nodes before linearized reading'  (duration: 102.653222ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T10:59:58.258927Z","caller":"traceutil/trace.go:171","msg":"trace[1757420508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26306; }","duration":"149.663418ms","start":"2026-10-06T10:59:58.109244Z","end":"2026-10-06T10:59:58.258908Z","steps":["trace[1757420508] 'agreement among raft nodes before linearized reading'  (duration: 149.514145ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:02.562442Z","caller":"traceutil/trace.go:171","msg":"trace[946784542] transaction","detail":"{read_only:false; response_revision:26439; number_of_response:1; }","duration":"119.333817ms","start":"2026-10-06T11:00:02.443083Z","end":"2026-10-06T11:00:02.562416Z","steps":["trace[946784542] 'process raft request'  (duration: 119.188914ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:02.970268Z","caller":"traceutil/trace.go:171","msg":"trace[787549414] transaction","detail":"{read_only:false; response_revision:26440; number_of_response:1; }","duration":"203.715925ms","start":"2026-10-06T11:00:02.766526Z","end":"2026-10-06T11:00:02.970242Z","steps":["trace[787549414] 'process raft request'  (duration: 203.568351ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:02.999986Z","caller":"traceutil/trace.go:171","msg":"trace[1089069620] linearizableReadLoop","detail":"{readStateIndex:27316; appliedIndex:27314; }","duration":"221.54893ms","start":"2026-10-06T11:00:02.778419Z","end":"2026-10-06T11:00:02.999968Z","steps":["trace[1089069620] 'read index received'  (duration: 191.683997ms)","trace[1089069620] 'applied index is now lower than readState.Index'  (duration: 29.864003ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:03.000196Z","caller":"traceutil/trace.go:171","msg":"trace[1476028241] transaction","detail":"{read_only:false; response_revision:26441; number_of_response:1; }","duration":"233.138928ms","start":"2026-10-06T11:00:02.767048Z","end":"2026-10-06T11:00:03.000187Z","steps":["trace[1476028241] 'process raft request'  (duration: 232.781241ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:03.000436Z","caller":"traceutil/trace.go:171","msg":"trace[544366299] transaction","detail":"{read_only:false; response_revision:26442; number_of_response:1; }","duration":"140.428903ms","start":"2026-10-06T11:00:02.86Z","end":"2026-10-06T11:00:03.000429Z","steps":["trace[544366299] 'process raft request'  (duration: 139.934754ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:03.00047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.92467ms","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-10-06T11:00:03.000553Z","caller":"traceutil/trace.go:171","msg":"trace[1172181665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26442; }","duration":"218.038083ms","start":"2026-10-06T11:00:02.782492Z","end":"2026-10-06T11:00:03.00053Z","steps":["trace[1172181665] 'agreement among raft nodes before linearized reading'  (duration: 217.781428ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:03.000663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.236812ms","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-10-06T11:00:03.000692Z","caller":"traceutil/trace.go:171","msg":"trace[1206661556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26442; }","duration":"222.304714ms","start":"2026-10-06T11:00:02.778379Z","end":"2026-10-06T11:00:03.000684Z","steps":["trace[1206661556] 'agreement among raft nodes before linearized reading'  (duration: 222.195612ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:03.223436Z","caller":"traceutil/trace.go:171","msg":"trace[136487163] transaction","detail":"{read_only:false; response_revision:26443; number_of_response:1; }","duration":"217.727038ms","start":"2026-10-06T11:00:03.005689Z","end":"2026-10-06T11:00:03.223416Z","steps":["trace[136487163] 'process raft request'  (duration: 217.598786ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:03.327438Z","caller":"traceutil/trace.go:171","msg":"trace[425904512] transaction","detail":"{read_only:false; response_revision:26444; number_of_response:1; }","duration":"320.940731ms","start":"2026-10-06T11:00:03.006476Z","end":"2026-10-06T11:00:03.327416Z","steps":["trace[425904512] 'process raft request'  (duration: 307.194692ms)","trace[425904512] 'compare'  (duration: 13.500864ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:03.327606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T11:00:03.006468Z","time spent":"321.083913ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26355 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-06T11:00:03.327713Z","caller":"traceutil/trace.go:171","msg":"trace[1348429751] transaction","detail":"{read_only:false; response_revision:26445; number_of_response:1; }","duration":"215.016367ms","start":"2026-10-06T11:00:03.112672Z","end":"2026-10-06T11:00:03.327688Z","steps":["trace[1348429751] 'process raft request'  (duration: 214.682131ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:03.327785Z","caller":"traceutil/trace.go:171","msg":"trace[1633846759] linearizableReadLoop","detail":"{readStateIndex:27319; appliedIndex:27317; }","duration":"317.407033ms","start":"2026-10-06T11:00:03.010354Z","end":"2026-10-06T11:00:03.327761Z","steps":["trace[1633846759] 'read index received'  (duration: 212.912847ms)","trace[1633846759] 'applied index is now lower than readState.Index'  (duration: 104.492866ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:03.327948Z","caller":"traceutil/trace.go:171","msg":"trace[190482074] transaction","detail":"{read_only:false; response_revision:26446; number_of_response:1; }","duration":"189.942495ms","start":"2026-10-06T11:00:03.137994Z","end":"2026-10-06T11:00:03.327936Z","steps":["trace[190482074] 'process raft request'  (duration: 189.586749ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:03.328016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.636627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-06T11:00:03.328073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.642511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-06T11:00:03.328094Z","caller":"traceutil/trace.go:171","msg":"trace[623883192] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:26446; }","duration":"317.74629ms","start":"2026-10-06T11:00:03.010332Z","end":"2026-10-06T11:00:03.328078Z","steps":["trace[623883192] 'agreement among raft nodes before linearized reading'  (duration: 317.618668ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:03.328124Z","caller":"traceutil/trace.go:171","msg":"trace[1497034752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26446; }","duration":"255.734623ms","start":"2026-10-06T11:00:03.072376Z","end":"2026-10-06T11:00:03.32811Z","steps":["trace[1497034752] 'agreement among raft nodes before linearized reading'  (duration: 255.570499ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:03.328137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T11:00:03.010324Z","time spent":"317.804051ms","remote":"127.0.0.1:57218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"info","ts":"2026-10-06T11:00:05.984905Z","caller":"traceutil/trace.go:171","msg":"trace[1024835621] transaction","detail":"{read_only:false; response_revision:26490; number_of_response:1; }","duration":"109.650424ms","start":"2026-10-06T11:00:05.875225Z","end":"2026-10-06T11:00:05.984876Z","steps":["trace[1024835621] 'process raft request'  (duration: 109.46956ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:05.984929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.767727ms","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-10-06T11:00:05.985187Z","caller":"traceutil/trace.go:171","msg":"trace[776336781] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26490; }","duration":"118.038532ms","start":"2026-10-06T11:00:05.867119Z","end":"2026-10-06T11:00:05.985157Z","steps":["trace[776336781] 'agreement among raft nodes before linearized reading'  (duration: 117.678135ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:07.546892Z","caller":"traceutil/trace.go:171","msg":"trace[1189805144] linearizableReadLoop","detail":"{readStateIndex:27386; appliedIndex:27385; }","duration":"163.359484ms","start":"2026-10-06T11:00:07.383481Z","end":"2026-10-06T11:00:07.54684Z","steps":["trace[1189805144] 'read index received'  (duration: 114.061037ms)","trace[1189805144] 'applied index is now lower than readState.Index'  (duration: 49.297417ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:07.547114Z","caller":"traceutil/trace.go:171","msg":"trace[152600163] transaction","detail":"{read_only:false; response_revision:26509; number_of_response:1; }","duration":"170.847775ms","start":"2026-10-06T11:00:07.376252Z","end":"2026-10-06T11:00:07.5471Z","steps":["trace[152600163] 'process raft request'  (duration: 121.276123ms)","trace[152600163] 'compare'  (duration: 49.167684ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:07.547405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.907454ms","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-10-06T11:00:07.547429Z","caller":"traceutil/trace.go:171","msg":"trace[1335262612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26509; }","duration":"163.986706ms","start":"2026-10-06T11:00:07.383436Z","end":"2026-10-06T11:00:07.547422Z","steps":["trace[1335262612] 'agreement among raft nodes before linearized reading'  (duration: 163.856213ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:07.547473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.403728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:9192"}
{"level":"info","ts":"2026-10-06T11:00:07.547535Z","caller":"traceutil/trace.go:171","msg":"trace[886604409] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26509; }","duration":"152.50639ms","start":"2026-10-06T11:00:07.395013Z","end":"2026-10-06T11:00:07.547519Z","steps":["trace[886604409] 'agreement among raft nodes before linearized reading'  (duration: 152.306266ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:07.547632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.029522ms","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-10-06T11:00:07.547699Z","caller":"traceutil/trace.go:171","msg":"trace[33748819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26509; }","duration":"151.138855ms","start":"2026-10-06T11:00:07.396542Z","end":"2026-10-06T11:00:07.547681Z","steps":["trace[33748819] 'agreement among raft nodes before linearized reading'  (duration: 150.913849ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:09.043041Z","caller":"traceutil/trace.go:171","msg":"trace[1049375776] transaction","detail":"{read_only:false; response_revision:26526; number_of_response:1; }","duration":"104.285243ms","start":"2026-10-06T11:00:08.938742Z","end":"2026-10-06T11:00:09.043027Z","steps":["trace[1049375776] 'process raft request'  (duration: 104.198701ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:10.225123Z","caller":"traceutil/trace.go:171","msg":"trace[158449925] linearizableReadLoop","detail":"{readStateIndex:27420; appliedIndex:27419; }","duration":"139.891053ms","start":"2026-10-06T11:00:10.085204Z","end":"2026-10-06T11:00:10.225095Z","steps":["trace[158449925] 'read index received'  (duration: 137.277474ms)","trace[158449925] 'applied index is now lower than readState.Index'  (duration: 2.612349ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:10.225342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.125907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/auth-system/keycloak\" ","response":"range_response_count:1 size:906"}
{"level":"info","ts":"2026-10-06T11:00:10.225383Z","caller":"traceutil/trace.go:171","msg":"trace[690750131] range","detail":"{range_begin:/registry/serviceaccounts/auth-system/keycloak; range_end:; response_count:1; response_revision:26542; }","duration":"140.218469ms","start":"2026-10-06T11:00:10.085153Z","end":"2026-10-06T11:00:10.225371Z","steps":["trace[690750131] 'agreement among raft nodes before linearized reading'  (duration: 140.041196ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:10.225561Z","caller":"traceutil/trace.go:171","msg":"trace[2107049448] transaction","detail":"{read_only:false; response_revision:26542; number_of_response:1; }","duration":"148.80449ms","start":"2026-10-06T11:00:10.076716Z","end":"2026-10-06T11:00:10.22552Z","steps":["trace[2107049448] 'process raft request'  (duration: 145.699202ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:16.606288Z","caller":"traceutil/trace.go:171","msg":"trace[2143277281] linearizableReadLoop","detail":"{readStateIndex:27487; appliedIndex:27486; }","duration":"131.981644ms","start":"2026-10-06T11:00:16.474282Z","end":"2026-10-06T11:00:16.606264Z","steps":["trace[2143277281] 'read index received'  (duration: 131.738989ms)","trace[2143277281] 'applied index is now lower than readState.Index'  (duration: 241.535µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:16.606425Z","caller":"traceutil/trace.go:171","msg":"trace[789085997] transaction","detail":"{read_only:false; response_revision:26608; number_of_response:1; }","duration":"231.910795ms","start":"2026-10-06T11:00:16.374494Z","end":"2026-10-06T11:00:16.606405Z","steps":["trace[789085997] 'process raft request'  (duration: 231.60351ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:16.606784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.978588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-10-06T11:00:16.606836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.504263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-10-06T11:00:16.606889Z","caller":"traceutil/trace.go:171","msg":"trace[328173553] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26608; }","duration":"112.122021ms","start":"2026-10-06T11:00:16.49473Z","end":"2026-10-06T11:00:16.606852Z","steps":["trace[328173553] 'agreement among raft nodes before linearized reading'  (duration: 111.846366ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:16.606925Z","caller":"traceutil/trace.go:171","msg":"trace[766983475] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:26608; }","duration":"132.675227ms","start":"2026-10-06T11:00:16.474231Z","end":"2026-10-06T11:00:16.606906Z","steps":["trace[766983475] 'agreement among raft nodes before linearized reading'  (duration: 132.342281ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:16.846158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.679621ms","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-10-06T11:00:16.84625Z","caller":"traceutil/trace.go:171","msg":"trace[79933701] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26609; }","duration":"163.832153ms","start":"2026-10-06T11:00:16.682394Z","end":"2026-10-06T11:00:16.846227Z","steps":["trace[79933701] 'range keys from in-memory index tree'  (duration: 163.562459ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:17.530349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.386732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-06T11:00:17.530439Z","caller":"traceutil/trace.go:171","msg":"trace[1487688594] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:26611; }","duration":"267.536584ms","start":"2026-10-06T11:00:17.262882Z","end":"2026-10-06T11:00:17.530419Z","steps":["trace[1487688594] 'count revisions from in-memory index tree'  (duration: 267.229979ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:17.530898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.754552ms","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-10-06T11:00:17.530977Z","caller":"traceutil/trace.go:171","msg":"trace[12874338] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26611; }","duration":"247.895885ms","start":"2026-10-06T11:00:17.28306Z","end":"2026-10-06T11:00:17.530955Z","steps":["trace[12874338] 'range keys from in-memory index tree'  (duration: 247.550188ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:17.531481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.960154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244504603 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:26600 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T11:00:17.531607Z","caller":"traceutil/trace.go:171","msg":"trace[37359866] transaction","detail":"{read_only:false; response_revision:26612; number_of_response:1; }","duration":"155.589498ms","start":"2026-10-06T11:00:17.375998Z","end":"2026-10-06T11:00:17.531588Z","steps":["trace[37359866] 'process raft request'  (duration: 40.194086ms)","trace[37359866] 'compare'  (duration: 114.281241ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:17.533511Z","caller":"traceutil/trace.go:171","msg":"trace[919914541] linearizableReadLoop","detail":"{readStateIndex:27492; appliedIndex:27490; }","duration":"128.102171ms","start":"2026-10-06T11:00:17.405363Z","end":"2026-10-06T11:00:17.533465Z","steps":["trace[919914541] 'read index received'  (duration: 10.730202ms)","trace[919914541] 'applied index is now lower than readState.Index'  (duration: 117.369769ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:17.533714Z","caller":"traceutil/trace.go:171","msg":"trace[1069559597] transaction","detail":"{read_only:false; response_revision:26613; number_of_response:1; }","duration":"143.831376ms","start":"2026-10-06T11:00:17.38985Z","end":"2026-10-06T11:00:17.533681Z","steps":["trace[1069559597] 'process raft request'  (duration: 143.314587ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:17.533832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.415547ms","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-10-06T11:00:17.533928Z","caller":"traceutil/trace.go:171","msg":"trace[2053201003] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:26613; }","duration":"128.602131ms","start":"2026-10-06T11:00:17.405304Z","end":"2026-10-06T11:00:17.533906Z","steps":["trace[2053201003] 'agreement among raft nodes before linearized reading'  (duration: 128.379186ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:17.533967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.021809ms","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-10-06T11:00:17.53406Z","caller":"traceutil/trace.go:171","msg":"trace[1513652049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26613; }","duration":"120.189302ms","start":"2026-10-06T11:00:17.413844Z","end":"2026-10-06T11:00:17.534034Z","steps":["trace[1513652049] 'agreement among raft nodes before linearized reading'  (duration: 119.895706ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:19.65237Z","caller":"traceutil/trace.go:171","msg":"trace[1412713297] linearizableReadLoop","detail":"{readStateIndex:27511; appliedIndex:27510; }","duration":"109.351978ms","start":"2026-10-06T11:00:19.542999Z","end":"2026-10-06T11:00:19.652351Z","steps":["trace[1412713297] 'read index received'  (duration: 84.512201ms)","trace[1412713297] 'applied index is now lower than readState.Index'  (duration: 24.838747ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:19.652647Z","caller":"traceutil/trace.go:171","msg":"trace[1599926660] transaction","detail":"{read_only:false; response_revision:26632; number_of_response:1; }","duration":"115.232048ms","start":"2026-10-06T11:00:19.537398Z","end":"2026-10-06T11:00:19.65263Z","steps":["trace[1599926660] 'process raft request'  (duration: 114.83748ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:19.65295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.935699ms","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-10-06T11:00:19.652991Z","caller":"traceutil/trace.go:171","msg":"trace[1416046873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26632; }","duration":"110.017342ms","start":"2026-10-06T11:00:19.542962Z","end":"2026-10-06T11:00:19.652979Z","steps":["trace[1416046873] 'agreement among raft nodes before linearized reading'  (duration: 109.868489ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:19.653185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.797107ms","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-10-06T11:00:19.653217Z","caller":"traceutil/trace.go:171","msg":"trace[1905804278] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26632; }","duration":"108.842949ms","start":"2026-10-06T11:00:19.544366Z","end":"2026-10-06T11:00:19.653209Z","steps":["trace[1905804278] 'agreement among raft nodes before linearized reading'  (duration: 108.754707ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:24.579693Z","caller":"traceutil/trace.go:171","msg":"trace[537097371] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"149.530884ms","start":"2026-10-06T11:00:24.430132Z","end":"2026-10-06T11:00:24.579663Z","steps":["trace[537097371] 'process raft request'  (duration: 125.083885ms)","trace[537097371] 'compare'  (duration: 24.257016ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:33.958307Z","caller":"traceutil/trace.go:171","msg":"trace[262932647] transaction","detail":"{read_only:false; response_revision:26765; number_of_response:1; }","duration":"138.222722ms","start":"2026-10-06T11:00:33.820064Z","end":"2026-10-06T11:00:33.958287Z","steps":["trace[262932647] 'process raft request'  (duration: 138.080949ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:34.045108Z","caller":"traceutil/trace.go:171","msg":"trace[1087198651] transaction","detail":"{read_only:false; response_revision:26768; number_of_response:1; }","duration":"221.367347ms","start":"2026-10-06T11:00:33.823715Z","end":"2026-10-06T11:00:34.045083Z","steps":["trace[1087198651] 'process raft request'  (duration: 221.295576ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:34.045111Z","caller":"traceutil/trace.go:171","msg":"trace[1107288565] transaction","detail":"{read_only:false; response_revision:26766; number_of_response:1; }","duration":"224.824602ms","start":"2026-10-06T11:00:33.820252Z","end":"2026-10-06T11:00:34.045077Z","steps":["trace[1107288565] 'process raft request'  (duration: 224.512726ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:34.045147Z","caller":"traceutil/trace.go:171","msg":"trace[697905301] transaction","detail":"{read_only:false; response_revision:26767; number_of_response:1; }","duration":"223.797852ms","start":"2026-10-06T11:00:33.821318Z","end":"2026-10-06T11:00:34.045116Z","steps":["trace[697905301] 'process raft request'  (duration: 223.64597ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:34.045236Z","caller":"traceutil/trace.go:171","msg":"trace[191860813] transaction","detail":"{read_only:false; response_revision:26769; number_of_response:1; }","duration":"129.557918ms","start":"2026-10-06T11:00:33.915646Z","end":"2026-10-06T11:00:34.045204Z","steps":["trace[191860813] 'process raft request'  (duration: 129.396195ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:34.045248Z","caller":"traceutil/trace.go:171","msg":"trace[1937644673] transaction","detail":"{read_only:false; response_revision:26770; number_of_response:1; }","duration":"129.496357ms","start":"2026-10-06T11:00:33.915735Z","end":"2026-10-06T11:00:34.045231Z","steps":["trace[1937644673] 'process raft request'  (duration: 129.391945ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:35.074681Z","caller":"traceutil/trace.go:171","msg":"trace[1551406643] transaction","detail":"{read_only:false; response_revision:26776; number_of_response:1; }","duration":"113.368994ms","start":"2026-10-06T11:00:34.961294Z","end":"2026-10-06T11:00:35.074663Z","steps":["trace[1551406643] 'process raft request'  (duration: 41.713735ms)","trace[1551406643] 'compare'  (duration: 71.435505ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:35.460098Z","caller":"traceutil/trace.go:171","msg":"trace[2088031497] transaction","detail":"{read_only:false; response_revision:26777; number_of_response:1; }","duration":"235.173336ms","start":"2026-10-06T11:00:35.2249Z","end":"2026-10-06T11:00:35.460073Z","steps":["trace[2088031497] 'process raft request'  (duration: 235.008513ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:35.47082Z","caller":"traceutil/trace.go:171","msg":"trace[321410888] linearizableReadLoop","detail":"{readStateIndex:27661; appliedIndex:27659; }","duration":"100.033522ms","start":"2026-10-06T11:00:35.370775Z","end":"2026-10-06T11:00:35.470809Z","steps":["trace[321410888] 'read index received'  (duration: 89.183218ms)","trace[321410888] 'applied index is now lower than readState.Index'  (duration: 10.849474ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:35.470904Z","caller":"traceutil/trace.go:171","msg":"trace[1549930915] transaction","detail":"{read_only:false; response_revision:26778; number_of_response:1; }","duration":"178.313555ms","start":"2026-10-06T11:00:35.292546Z","end":"2026-10-06T11:00:35.47086Z","steps":["trace[1549930915] 'process raft request'  (duration: 178.206753ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:35.470987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.183945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:35.47106Z","caller":"traceutil/trace.go:171","msg":"trace[897818856] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:26778; }","duration":"100.306167ms","start":"2026-10-06T11:00:35.370732Z","end":"2026-10-06T11:00:35.471038Z","steps":["trace[897818856] 'agreement among raft nodes before linearized reading'  (duration: 100.144034ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:44.31931Z","caller":"traceutil/trace.go:171","msg":"trace[251571741] linearizableReadLoop","detail":"{readStateIndex:27725; appliedIndex:27723; }","duration":"236.102513ms","start":"2026-10-06T11:00:44.083188Z","end":"2026-10-06T11:00:44.31929Z","steps":["trace[251571741] 'read index received'  (duration: 64.274369ms)","trace[251571741] 'applied index is now lower than readState.Index'  (duration: 171.827174ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:44.319538Z","caller":"traceutil/trace.go:171","msg":"trace[303553249] transaction","detail":"{read_only:false; response_revision:26841; number_of_response:1; }","duration":"240.558387ms","start":"2026-10-06T11:00:44.078965Z","end":"2026-10-06T11:00:44.319524Z","steps":["trace[303553249] 'process raft request'  (duration: 145.978517ms)","trace[303553249] 'compare'  (duration: 93.912098ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:44.319792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.818484ms","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-10-06T11:00:44.319859Z","caller":"traceutil/trace.go:171","msg":"trace[1316216173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26841; }","duration":"231.911895ms","start":"2026-10-06T11:00:44.087929Z","end":"2026-10-06T11:00:44.319841Z","steps":["trace[1316216173] 'agreement among raft nodes before linearized reading'  (duration: 231.709791ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:44.319849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.633403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-10-06T11:00:44.319865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.570835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-06T11:00:44.319952Z","caller":"traceutil/trace.go:171","msg":"trace[1153615730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26841; }","duration":"236.776776ms","start":"2026-10-06T11:00:44.083156Z","end":"2026-10-06T11:00:44.319933Z","steps":["trace[1153615730] 'agreement among raft nodes before linearized reading'  (duration: 236.511411ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:44.319974Z","caller":"traceutil/trace.go:171","msg":"trace[773823665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26841; }","duration":"225.708377ms","start":"2026-10-06T11:00:44.094244Z","end":"2026-10-06T11:00:44.319953Z","steps":["trace[773823665] 'agreement among raft nodes before linearized reading'  (duration: 225.413292ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:44.631016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.612368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244505149 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26829 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T11:00:44.631131Z","caller":"traceutil/trace.go:171","msg":"trace[800869105] linearizableReadLoop","detail":"{readStateIndex:27728; appliedIndex:27725; }","duration":"284.422282ms","start":"2026-10-06T11:00:44.346699Z","end":"2026-10-06T11:00:44.631121Z","steps":["trace[800869105] 'read index received'  (duration: 50.634413ms)","trace[800869105] 'applied index is now lower than readState.Index'  (duration: 233.787069ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:44.63119Z","caller":"traceutil/trace.go:171","msg":"trace[1861964280] transaction","detail":"{read_only:false; response_revision:26844; number_of_response:1; }","duration":"306.486458ms","start":"2026-10-06T11:00:44.324698Z","end":"2026-10-06T11:00:44.631184Z","steps":["trace[1861964280] 'process raft request'  (duration: 306.382696ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:44.631224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T11:00:44.324665Z","time spent":"306.541579ms","remote":"127.0.0.1:57362","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:26830 > 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":"info","ts":"2026-10-06T11:00:44.631241Z","caller":"traceutil/trace.go:171","msg":"trace[936363004] transaction","detail":"{read_only:false; response_revision:26843; number_of_response:1; }","duration":"306.672991ms","start":"2026-10-06T11:00:44.324543Z","end":"2026-10-06T11:00:44.631216Z","steps":["trace[936363004] 'process raft request'  (duration: 166.787358ms)","trace[936363004] 'compare'  (duration: 139.375554ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:44.631358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T11:00:44.324521Z","time spent":"306.771613ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26829 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-06T11:00:44.631391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.691377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.20\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-10-06T11:00:44.631408Z","caller":"traceutil/trace.go:171","msg":"trace[1847336978] range","detail":"{range_begin:/registry/masterleases/162.253.55.20; range_end:; response_count:1; response_revision:26844; }","duration":"284.707348ms","start":"2026-10-06T11:00:44.346694Z","end":"2026-10-06T11:00:44.631401Z","steps":["trace[1847336978] 'agreement among raft nodes before linearized reading'  (duration: 284.637206ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:44.631525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.336843ms","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-10-06T11:00:44.631543Z","caller":"traceutil/trace.go:171","msg":"trace[1617040385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26844; }","duration":"231.390674ms","start":"2026-10-06T11:00:44.400148Z","end":"2026-10-06T11:00:44.631538Z","steps":["trace[1617040385] 'agreement among raft nodes before linearized reading'  (duration: 231.343783ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:44.631726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.990086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:44.631785Z","caller":"traceutil/trace.go:171","msg":"trace[933596108] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:26844; }","duration":"113.102828ms","start":"2026-10-06T11:00:44.518669Z","end":"2026-10-06T11:00:44.631772Z","steps":["trace[933596108] 'agreement among raft nodes before linearized reading'  (duration: 113.002387ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:44.886779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.07815ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244505154 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:7f69a110ae721c41>","response":"size:41"}
{"level":"info","ts":"2026-10-06T11:00:44.901642Z","caller":"traceutil/trace.go:171","msg":"trace[458292746] transaction","detail":"{read_only:false; response_revision:26846; number_of_response:1; }","duration":"153.622191ms","start":"2026-10-06T11:00:44.748Z","end":"2026-10-06T11:00:44.901622Z","steps":["trace[458292746] 'process raft request'  (duration: 153.55636ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:44.90195Z","caller":"traceutil/trace.go:171","msg":"trace[2080851127] transaction","detail":"{read_only:false; response_revision:26845; number_of_response:1; }","duration":"265.863854ms","start":"2026-10-06T11:00:44.636075Z","end":"2026-10-06T11:00:44.901939Z","steps":["trace[2080851127] 'process raft request'  (duration: 265.353665ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:45.078306Z","caller":"traceutil/trace.go:171","msg":"trace[2144543964] linearizableReadLoop","detail":"{readStateIndex:27733; appliedIndex:27732; }","duration":"123.694158ms","start":"2026-10-06T11:00:44.954586Z","end":"2026-10-06T11:00:45.078281Z","steps":["trace[2144543964] 'read index received'  (duration: 44.282573ms)","trace[2144543964] 'applied index is now lower than readState.Index'  (duration: 79.410545ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:45.078478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.875441ms","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-10-06T11:00:45.078519Z","caller":"traceutil/trace.go:171","msg":"trace[375770578] 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:26848; }","duration":"123.958823ms","start":"2026-10-06T11:00:44.954546Z","end":"2026-10-06T11:00:45.078505Z","steps":["trace[375770578] 'agreement among raft nodes before linearized reading'  (duration: 123.877702ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:45.078678Z","caller":"traceutil/trace.go:171","msg":"trace[1383206716] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"143.139694ms","start":"2026-10-06T11:00:44.935205Z","end":"2026-10-06T11:00:45.078345Z","steps":["trace[1383206716] 'process raft request'  (duration: 63.739599ms)","trace[1383206716] 'compare'  (duration: 79.223372ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:45.275132Z","caller":"traceutil/trace.go:171","msg":"trace[839079187] transaction","detail":"{read_only:false; response_revision:26849; number_of_response:1; }","duration":"190.260471ms","start":"2026-10-06T11:00:45.084833Z","end":"2026-10-06T11:00:45.275094Z","steps":["trace[839079187] 'process raft request'  (duration: 138.237571ms)","trace[839079187] 'compare'  (duration: 51.844806ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:45.275299Z","caller":"traceutil/trace.go:171","msg":"trace[685173865] linearizableReadLoop","detail":"{readStateIndex:27734; appliedIndex:27733; }","duration":"187.01298ms","start":"2026-10-06T11:00:45.088264Z","end":"2026-10-06T11:00:45.275277Z","steps":["trace[685173865] 'read index received'  (duration: 134.89652ms)","trace[685173865] 'applied index is now lower than readState.Index'  (duration: 52.11545ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:45.275461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.179553ms","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-10-06T11:00:45.275499Z","caller":"traceutil/trace.go:171","msg":"trace[522490615] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26850; }","duration":"187.294395ms","start":"2026-10-06T11:00:45.088192Z","end":"2026-10-06T11:00:45.275487Z","steps":["trace[522490615] 'agreement among raft nodes before linearized reading'  (duration: 187.214443ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:45.92931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.595854ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244505175 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26838 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T11:00:45.929469Z","caller":"traceutil/trace.go:171","msg":"trace[1376901634] linearizableReadLoop","detail":"{readStateIndex:27740; appliedIndex:27739; }","duration":"155.143611ms","start":"2026-10-06T11:00:45.774273Z","end":"2026-10-06T11:00:45.929416Z","steps":["trace[1376901634] 'read index received'  (duration: 37.315013ms)","trace[1376901634] 'applied index is now lower than readState.Index'  (duration: 117.826718ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:45.929696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.409636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:45.929771Z","caller":"traceutil/trace.go:171","msg":"trace[1638180272] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:26855; }","duration":"155.497757ms","start":"2026-10-06T11:00:45.774257Z","end":"2026-10-06T11:00:45.929755Z","steps":["trace[1638180272] 'agreement among raft nodes before linearized reading'  (duration: 155.365135ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:45.929782Z","caller":"traceutil/trace.go:171","msg":"trace[1139154114] transaction","detail":"{read_only:false; response_revision:26855; number_of_response:1; }","duration":"156.155819ms","start":"2026-10-06T11:00:45.773606Z","end":"2026-10-06T11:00:45.929761Z","steps":["trace[1139154114] 'process raft request'  (duration: 37.988685ms)","trace[1139154114] 'compare'  (duration: 117.441461ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:45.92992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.862917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"}
{"level":"info","ts":"2026-10-06T11:00:45.929987Z","caller":"traceutil/trace.go:171","msg":"trace[1721457688] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26855; }","duration":"109.99191ms","start":"2026-10-06T11:00:45.819976Z","end":"2026-10-06T11:00:45.929968Z","steps":["trace[1721457688] 'agreement among raft nodes before linearized reading'  (duration: 109.722095ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:46.225105Z","caller":"traceutil/trace.go:171","msg":"trace[1363123046] transaction","detail":"{read_only:false; response_revision:26856; number_of_response:1; }","duration":"136.350906ms","start":"2026-10-06T11:00:46.088711Z","end":"2026-10-06T11:00:46.225061Z","steps":["trace[1363123046] 'process raft request'  (duration: 136.131752ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:47.015866Z","caller":"traceutil/trace.go:171","msg":"trace[1602861591] transaction","detail":"{read_only:false; response_revision:26862; number_of_response:1; }","duration":"106.244619ms","start":"2026-10-06T11:00:46.909597Z","end":"2026-10-06T11:00:47.015842Z","steps":["trace[1602861591] 'process raft request'  (duration: 106.077156ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:47.059463Z","caller":"traceutil/trace.go:171","msg":"trace[851402703] transaction","detail":"{read_only:false; response_revision:26863; number_of_response:1; }","duration":"145.933427ms","start":"2026-10-06T11:00:46.913501Z","end":"2026-10-06T11:00:47.059434Z","steps":["trace[851402703] 'process raft request'  (duration: 145.741923ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:47.30311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.825837ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244505197 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26848 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T11:00:47.303605Z","caller":"traceutil/trace.go:171","msg":"trace[1360921677] transaction","detail":"{read_only:false; response_revision:26864; number_of_response:1; }","duration":"219.063813ms","start":"2026-10-06T11:00:47.084454Z","end":"2026-10-06T11:00:47.303518Z","steps":["trace[1360921677] 'process raft request'  (duration: 108.743227ms)","trace[1360921677] 'compare'  (duration: 109.380069ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:47.662734Z","caller":"traceutil/trace.go:171","msg":"trace[1975606064] transaction","detail":"{read_only:false; response_revision:26865; number_of_response:1; }","duration":"163.082329ms","start":"2026-10-06T11:00:47.499626Z","end":"2026-10-06T11:00:47.662709Z","steps":["trace[1975606064] 'process raft request'  (duration: 162.898996ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:47.836809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.04893ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244505203 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26853 > 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-10-06T11:00:47.836937Z","caller":"traceutil/trace.go:171","msg":"trace[889489685] linearizableReadLoop","detail":"{readStateIndex:27751; appliedIndex:27749; }","duration":"286.32821ms","start":"2026-10-06T11:00:47.55059Z","end":"2026-10-06T11:00:47.836918Z","steps":["trace[889489685] 'read index received'  (duration: 112.021629ms)","trace[889489685] 'applied index is now lower than readState.Index'  (duration: 174.305081ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:47.837004Z","caller":"traceutil/trace.go:171","msg":"trace[366047319] transaction","detail":"{read_only:false; response_revision:26866; number_of_response:1; }","duration":"332.013199ms","start":"2026-10-06T11:00:47.50498Z","end":"2026-10-06T11:00:47.836993Z","steps":["trace[366047319] 'process raft request'  (duration: 178.689413ms)","trace[366047319] 'compare'  (duration: 152.915718ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:47.837058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T11:00:47.504951Z","time spent":"332.077161ms","remote":"127.0.0.1:57362","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:26853 > 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-10-06T11:00:47.837097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.485593ms","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-10-06T11:00:47.837182Z","caller":"traceutil/trace.go:171","msg":"trace[515537467] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26866; }","duration":"286.616385ms","start":"2026-10-06T11:00:47.550543Z","end":"2026-10-06T11:00:47.837159Z","steps":["trace[515537467] 'agreement among raft nodes before linearized reading'  (duration: 286.479733ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:47.873919Z","caller":"traceutil/trace.go:171","msg":"trace[907717411] transaction","detail":"{read_only:false; response_revision:26867; number_of_response:1; }","duration":"125.106015ms","start":"2026-10-06T11:00:47.748767Z","end":"2026-10-06T11:00:47.873874Z","steps":["trace[907717411] 'process raft request'  (duration: 124.608136ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:47.874012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.48829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:47.874096Z","caller":"traceutil/trace.go:171","msg":"trace[1350019194] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26867; }","duration":"245.630183ms","start":"2026-10-06T11:00:47.628445Z","end":"2026-10-06T11:00:47.874075Z","steps":["trace[1350019194] 'agreement among raft nodes before linearized reading'  (duration: 245.48645ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:48.084207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.042811ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18404418445244505212 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26855 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-06T11:00:48.084323Z","caller":"traceutil/trace.go:171","msg":"trace[968920896] linearizableReadLoop","detail":"{readStateIndex:27753; appliedIndex:27752; }","duration":"131.7962ms","start":"2026-10-06T11:00:47.952505Z","end":"2026-10-06T11:00:48.084302Z","steps":["trace[968920896] 'read index received'  (duration: 21.463203ms)","trace[968920896] 'applied index is now lower than readState.Index'  (duration: 110.330947ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:48.084447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.952103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:48.084486Z","caller":"traceutil/trace.go:171","msg":"trace[1540159297] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:26868; }","duration":"132.050785ms","start":"2026-10-06T11:00:47.952424Z","end":"2026-10-06T11:00:48.084475Z","steps":["trace[1540159297] 'agreement among raft nodes before linearized reading'  (duration: 131.932972ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:48.084728Z","caller":"traceutil/trace.go:171","msg":"trace[125350651] transaction","detail":"{read_only:false; response_revision:26868; number_of_response:1; }","duration":"150.170387ms","start":"2026-10-06T11:00:47.934544Z","end":"2026-10-06T11:00:48.084714Z","steps":["trace[125350651] 'process raft request'  (duration: 39.516245ms)","trace[125350651] 'compare'  (duration: 109.652324ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:48.543991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.283479ms","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-10-06T11:00:48.544072Z","caller":"traceutil/trace.go:171","msg":"trace[1809931635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26871; }","duration":"132.419002ms","start":"2026-10-06T11:00:48.411633Z","end":"2026-10-06T11:00:48.544052Z","steps":["trace[1809931635] 'range keys from in-memory index tree'  (duration: 132.029605ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:48.587734Z","caller":"traceutil/trace.go:171","msg":"trace[1854810006] transaction","detail":"{read_only:false; response_revision:26872; number_of_response:1; }","duration":"123.338991ms","start":"2026-10-06T11:00:48.46437Z","end":"2026-10-06T11:00:48.587709Z","steps":["trace[1854810006] 'process raft request'  (duration: 123.157148ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:48.791588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.526746ms","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-10-06T11:00:48.791678Z","caller":"traceutil/trace.go:171","msg":"trace[452725689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26873; }","duration":"147.675279ms","start":"2026-10-06T11:00:48.643982Z","end":"2026-10-06T11:00:48.791658Z","steps":["trace[452725689] 'range keys from in-memory index tree'  (duration: 147.330722ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:48.791525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.372765ms","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-10-06T11:00:48.79175Z","caller":"traceutil/trace.go:171","msg":"trace[275952992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26873; }","duration":"146.62584ms","start":"2026-10-06T11:00:48.645089Z","end":"2026-10-06T11:00:48.791715Z","steps":["trace[275952992] 'range keys from in-memory index tree'  (duration: 146.216032ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:48.990681Z","caller":"traceutil/trace.go:171","msg":"trace[1207547723] linearizableReadLoop","detail":"{readStateIndex:27760; appliedIndex:27759; }","duration":"122.80767ms","start":"2026-10-06T11:00:48.867852Z","end":"2026-10-06T11:00:48.99066Z","steps":["trace[1207547723] 'read index received'  (duration: 29.425693ms)","trace[1207547723] 'applied index is now lower than readState.Index'  (duration: 93.380807ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:00:48.990747Z","caller":"traceutil/trace.go:171","msg":"trace[1079890613] transaction","detail":"{read_only:false; response_revision:26875; number_of_response:1; }","duration":"193.443571ms","start":"2026-10-06T11:00:48.797254Z","end":"2026-10-06T11:00:48.990698Z","steps":["trace[1079890613] 'process raft request'  (duration: 100.074644ms)","trace[1079890613] 'compare'  (duration: 93.108922ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:48.990822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.800186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:48.990853Z","caller":"traceutil/trace.go:171","msg":"trace[691156111] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:26875; }","duration":"101.876757ms","start":"2026-10-06T11:00:48.888966Z","end":"2026-10-06T11:00:48.990843Z","steps":["trace[691156111] 'agreement among raft nodes before linearized reading'  (duration: 101.808405ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:00:48.990836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.959073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:48.990919Z","caller":"traceutil/trace.go:171","msg":"trace[1286529642] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:26875; }","duration":"123.055865ms","start":"2026-10-06T11:00:48.867817Z","end":"2026-10-06T11:00:48.990873Z","steps":["trace[1286529642] 'agreement among raft nodes before linearized reading'  (duration: 122.946563ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:49.14401Z","caller":"traceutil/trace.go:171","msg":"trace[1957744919] linearizableReadLoop","detail":"{readStateIndex:27761; appliedIndex:27760; }","duration":"103.502508ms","start":"2026-10-06T11:00:49.04048Z","end":"2026-10-06T11:00:49.143982Z","steps":["trace[1957744919] 'read index received'  (duration: 64.204299ms)","trace[1957744919] 'applied index is now lower than readState.Index'  (duration: 39.296669ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:00:49.144266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.761483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:00:49.144345Z","caller":"traceutil/trace.go:171","msg":"trace[843948390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26876; }","duration":"103.916146ms","start":"2026-10-06T11:00:49.040417Z","end":"2026-10-06T11:00:49.144333Z","steps":["trace[843948390] 'agreement among raft nodes before linearized reading'  (duration: 103.782673ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:00:49.144091Z","caller":"traceutil/trace.go:171","msg":"trace[163549916] transaction","detail":"{read_only:false; response_revision:26876; number_of_response:1; }","duration":"122.443605ms","start":"2026-10-06T11:00:49.021614Z","end":"2026-10-06T11:00:49.144058Z","steps":["trace[163549916] 'process raft request'  (duration: 83.075444ms)","trace[163549916] 'compare'  (duration: 39.142996ms)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:01:04.56031Z","caller":"traceutil/trace.go:171","msg":"trace[295530723] linearizableReadLoop","detail":"{readStateIndex:27889; appliedIndex:27888; }","duration":"106.26189ms","start":"2026-10-06T11:01:04.454028Z","end":"2026-10-06T11:01:04.56029Z","steps":["trace[295530723] 'read index received'  (duration: 106.033986ms)","trace[295530723] 'applied index is now lower than readState.Index'  (duration: 226.904µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:01:04.560438Z","caller":"traceutil/trace.go:171","msg":"trace[8967651] transaction","detail":"{read_only:false; response_revision:27000; number_of_response:1; }","duration":"108.510111ms","start":"2026-10-06T11:01:04.451897Z","end":"2026-10-06T11:01:04.560407Z","steps":["trace[8967651] 'process raft request'  (duration: 108.229526ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:01:04.560678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.596796ms","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-10-06T11:01:04.560729Z","caller":"traceutil/trace.go:171","msg":"trace[1677423737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27000; }","duration":"106.733949ms","start":"2026-10-06T11:01:04.453981Z","end":"2026-10-06T11:01:04.560715Z","steps":["trace[1677423737] 'agreement among raft nodes before linearized reading'  (duration: 106.400703ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:01:10.22839Z","caller":"traceutil/trace.go:171","msg":"trace[1582021282] linearizableReadLoop","detail":"{readStateIndex:27932; appliedIndex:27931; }","duration":"186.775156ms","start":"2026-10-06T11:01:10.041587Z","end":"2026-10-06T11:01:10.228363Z","steps":["trace[1582021282] 'read index received'  (duration: 186.702715ms)","trace[1582021282] 'applied index is now lower than readState.Index'  (duration: 71.231µs)"],"step_count":2}
{"level":"info","ts":"2026-10-06T11:01:10.228446Z","caller":"traceutil/trace.go:171","msg":"trace[530265596] transaction","detail":"{read_only:false; response_revision:27042; number_of_response:1; }","duration":"272.726063ms","start":"2026-10-06T11:01:09.95569Z","end":"2026-10-06T11:01:10.228416Z","steps":["trace[530265596] 'process raft request'  (duration: 272.491119ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:01:10.228556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.955409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:01:10.228594Z","caller":"traceutil/trace.go:171","msg":"trace[1611782950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27042; }","duration":"187.047401ms","start":"2026-10-06T11:01:10.041534Z","end":"2026-10-06T11:01:10.228582Z","steps":["trace[1611782950] 'agreement among raft nodes before linearized reading'  (duration: 186.96412ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:01:10.426149Z","caller":"traceutil/trace.go:171","msg":"trace[149456650] transaction","detail":"{read_only:false; response_revision:27044; number_of_response:1; }","duration":"112.154271ms","start":"2026-10-06T11:01:10.313975Z","end":"2026-10-06T11:01:10.426129Z","steps":["trace[149456650] 'process raft request'  (duration: 112.10329ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:01:10.426335Z","caller":"traceutil/trace.go:171","msg":"trace[710370733] linearizableReadLoop","detail":"{readStateIndex:27933; appliedIndex:27932; }","duration":"197.829523ms","start":"2026-10-06T11:01:10.228467Z","end":"2026-10-06T11:01:10.426297Z","steps":["trace[710370733] 'read index received'  (duration: 120.479518ms)","trace[710370733] 'applied index is now lower than readState.Index'  (duration: 77.346345ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:01:10.426452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.047625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:01:10.426296Z","caller":"traceutil/trace.go:171","msg":"trace[1389543945] transaction","detail":"{read_only:false; response_revision:27043; number_of_response:1; }","duration":"260.854549ms","start":"2026-10-06T11:01:10.1654Z","end":"2026-10-06T11:01:10.426254Z","steps":["trace[1389543945] 'process raft request'  (duration: 183.546955ms)","trace[1389543945] 'compare'  (duration: 76.224124ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-06T11:01:10.426521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.04892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-06T11:01:10.426533Z","caller":"traceutil/trace.go:171","msg":"trace[1167435624] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:27044; }","duration":"200.148967ms","start":"2026-10-06T11:01:10.226366Z","end":"2026-10-06T11:01:10.426515Z","steps":["trace[1167435624] 'agreement among raft nodes before linearized reading'  (duration: 199.955863ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:01:10.42658Z","caller":"traceutil/trace.go:171","msg":"trace[1871508319] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:27044; }","duration":"281.170752ms","start":"2026-10-06T11:01:10.145391Z","end":"2026-10-06T11:01:10.426562Z","steps":["trace[1871508319] 'agreement among raft nodes before linearized reading'  (duration: 281.005519ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-06T11:01:10.449103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.379368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-06T11:01:10.449178Z","caller":"traceutil/trace.go:171","msg":"trace[546307168] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27045; }","duration":"219.502991ms","start":"2026-10-06T11:01:10.229654Z","end":"2026-10-06T11:01:10.449157Z","steps":["trace[546307168] 'agreement among raft nodes before linearized reading'  (duration: 219.346958ms)"],"step_count":1}
{"level":"info","ts":"2026-10-06T11:02:10.713392Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24787}
{"level":"info","ts":"2026-10-06T11:02:10.871917Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24787,"took":"154.145282ms","hash":51315993,"current-db-size-bytes":58003456,"current-db-size":"58 MB","current-db-size-in-use-bytes":36589568,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-10-06T11:02:10.871985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":51315993,"revision":24787,"compact-revision":21585}
{"level":"info","ts":"2026-10-06T11:04:31.744437Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"eae99266654eff69","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-06T11:04:31.751862Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-06T11:04:31.75198Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-06T11:07:10.721624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27691}
{"level":"info","ts":"2026-10-06T11:07:10.874654Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27691,"took":"148.724499ms","hash":3360034554,"current-db-size-bytes":58003456,"current-db-size":"58 MB","current-db-size-in-use-bytes":34963456,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-06T11:07:10.874764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3360034554,"revision":27691,"compact-revision":24787}
{"level":"info","ts":"2026-10-06T11:12:10.728581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30398}
{"level":"info","ts":"2026-10-06T11:12:10.882186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30398,"took":"149.580816ms","hash":2349230062,"current-db-size-bytes":58003456,"current-db-size":"58 MB","current-db-size-in-use-bytes":30793728,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-06T11:12:10.882301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2349230062,"revision":30398,"compact-revision":27691}
{"level":"info","ts":"2026-10-06T11:17:10.738372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32652}
{"level":"info","ts":"2026-10-06T11:17:10.896187Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32652,"took":"152.027331ms","hash":316953832,"current-db-size-bytes":58003456,"current-db-size":"58 MB","current-db-size-in-use-bytes":30318592,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-06T11:17:10.896253Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":316953832,"revision":32652,"compact-revision":30398}
{"level":"info","ts":"2026-10-06T11:22:10.750066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34885}
{"level":"info","ts":"2026-10-06T11:22:10.901237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34885,"took":"146.619528ms","hash":2680189855,"current-db-size-bytes":58003456,"current-db-size":"58 MB","current-db-size-in-use-bytes":31240192,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-06T11:22:10.901324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2680189855,"revision":34885,"compact-revision":32652}
{"level":"info","ts":"2026-10-06T11:25:40.545604Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"eae99266654eff69","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-06T11:25:40.552601Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-06T11:25:40.552704Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-06T11:27:10.757516Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37177}
{"level":"info","ts":"2026-10-06T11:27:10.894711Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37177,"took":"130.608885ms","hash":1057461050,"current-db-size-bytes":58003456,"current-db-size":"58 MB","current-db-size-in-use-bytes":32075776,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-06T11:27:10.894807Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1057461050,"revision":37177,"compact-revision":34885}
{"level":"info","ts":"2026-10-06T11:32:10.764803Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39451}
{"level":"info","ts":"2026-10-06T11:32:10.914485Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39451,"took":"144.625732ms","hash":1894090276,"current-db-size-bytes":59703296,"current-db-size":"60 MB","current-db-size-in-use-bytes":31600640,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-06T11:32:10.914558Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1894090276,"revision":39451,"compact-revision":37177}
{"level":"info","ts":"2026-10-06T11:37:10.773989Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41685}
{"level":"info","ts":"2026-10-06T11:37:10.898686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41685,"took":"120.528991ms","hash":4265792909,"current-db-size-bytes":59703296,"current-db-size":"60 MB","current-db-size-in-use-bytes":29487104,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-06T11:37:10.898749Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4265792909,"revision":41685,"compact-revision":39451}