{"level":"warn","ts":"2026-10-04T05:47:52.80458Z","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-04T05:47:52.804716Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.84: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.84:2380","--initial-cluster=instance=https://162.253.55.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.84: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-04T05:47:52.804839Z","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-04T05:47:52.804865Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.84:2380"]}
{"level":"info","ts":"2026-10-04T05:47:52.804895Z","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-04T05:47:52.805741Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"]}
{"level":"info","ts":"2026-10-04T05:47:52.805843Z","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.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.84: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-04T05:47:52.808872Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.70878ms"}
{"level":"info","ts":"2026-10-04T05:47:52.81433Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca4c710a8d5349d7","cluster-id":"8e28a51debf1c8ab"}
{"level":"info","ts":"2026-10-04T05:47:52.814419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-04T05:47:52.81444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 0"}
{"level":"info","ts":"2026-10-04T05:47:52.814454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca4c710a8d5349d7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-04T05:47:52.814462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 1"}
{"level":"info","ts":"2026-10-04T05:47:52.814508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"}
{"level":"warn","ts":"2026-10-04T05:47:52.819865Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-04T05:47:52.821651Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-04T05:47:52.822966Z","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-04T05:47:52.825457Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca4c710a8d5349d7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-04T05:47:52.825641Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca4c710a8d5349d7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-04T05:47:52.82577Z","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-04T05:47:52.825828Z","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-04T05:47:52.82584Z","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-04T05:47:52.827061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"}
{"level":"info","ts":"2026-10-04T05:47:52.828485Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","added-peer-id":"ca4c710a8d5349d7","added-peer-peer-urls":["https://162.253.55.84:2380"]}
{"level":"info","ts":"2026-10-04T05:47:52.831241Z","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-04T05:47:52.831434Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.84:2380"}
{"level":"info","ts":"2026-10-04T05:47:52.831518Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.84:2380"}
{"level":"info","ts":"2026-10-04T05:47:52.831737Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca4c710a8d5349d7","initial-advertise-peer-urls":["https://162.253.55.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-04T05:47:52.831847Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-04T05:47:52.915547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-04T05:47:52.915635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-04T05:47:52.915672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgPreVoteResp from ca4c710a8d5349d7 at term 1"}
{"level":"info","ts":"2026-10-04T05:47:52.915699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became candidate at term 2"}
{"level":"info","ts":"2026-10-04T05:47:52.915717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgVoteResp from ca4c710a8d5349d7 at term 2"}
{"level":"info","ts":"2026-10-04T05:47:52.915748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became leader at term 2"}
{"level":"info","ts":"2026-10-04T05:47:52.915767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca4c710a8d5349d7 elected leader ca4c710a8d5349d7 at term 2"}
{"level":"info","ts":"2026-10-04T05:47:52.917304Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T05:47:52.917376Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T05:47:52.917448Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T05:47:52.917963Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-04T05:47:52.918097Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-04T05:47:52.918471Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T05:47:52.918607Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T05:47:52.918651Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T05:47:52.920802Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-04T05:47:52.917322Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca4c710a8d5349d7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.84:2379]}","request-path":"/0/members/ca4c710a8d5349d7/attributes","cluster-id":"8e28a51debf1c8ab","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-04T05:47:52.922145Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.84:2379"}
{"level":"info","ts":"2026-10-04T05:48:38.211594Z","caller":"traceutil/trace.go:171","msg":"trace[1719149481] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"115.042982ms","start":"2026-10-04T05:48:38.096524Z","end":"2026-10-04T05:48:38.211567Z","steps":["trace[1719149481] 'process raft request'  (duration: 113.783519ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:48:38.276096Z","caller":"traceutil/trace.go:171","msg":"trace[1986673079] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"167.680813ms","start":"2026-10-04T05:48:38.108378Z","end":"2026-10-04T05:48:38.276059Z","steps":["trace[1986673079] 'process raft request'  (duration: 167.090008ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:48:40.122993Z","caller":"traceutil/trace.go:171","msg":"trace[577585843] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"118.930723ms","start":"2026-10-04T05:48:40.004022Z","end":"2026-10-04T05:48:40.122953Z","steps":["trace[577585843] 'process raft request'  (duration: 103.887134ms)","trace[577585843] 'compare'  (duration: 14.861884ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:50:18.028117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.008233ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T05:50:18.028547Z","caller":"traceutil/trace.go:171","msg":"trace[86067830] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1860; }","duration":"318.455784ms","start":"2026-10-04T05:50:17.710036Z","end":"2026-10-04T05:50:18.028492Z","steps":["trace[86067830] 'range keys from in-memory index tree'  (duration: 317.946061ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:50:18.029363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.319118ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560263922 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1827 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T05:50:18.029546Z","caller":"traceutil/trace.go:171","msg":"trace[1114241703] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"352.477983ms","start":"2026-10-04T05:50:17.677017Z","end":"2026-10-04T05:50:18.029495Z","steps":["trace[1114241703] 'process raft request'  (duration: 63.098337ms)","trace[1114241703] 'compare'  (duration: 288.071462ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:50:18.029668Z","caller":"traceutil/trace.go:171","msg":"trace[1165495546] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"106.187019ms","start":"2026-10-04T05:50:17.923455Z","end":"2026-10-04T05:50:18.029643Z","steps":["trace[1165495546] 'process raft request'  (duration: 106.053396ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:50:18.029633Z","caller":"traceutil/trace.go:171","msg":"trace[1123520408] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1935; }","duration":"338.973604ms","start":"2026-10-04T05:50:17.690614Z","end":"2026-10-04T05:50:18.029587Z","steps":["trace[1123520408] 'read index received'  (duration: 49.401284ms)","trace[1123520408] 'applied index is now lower than readState.Index'  (duration: 289.56658ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:50:18.029773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T05:50:17.676977Z","time spent":"352.675578ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1827 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T05:50:18.029956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.293602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T05:50:18.030013Z","caller":"traceutil/trace.go:171","msg":"trace[1751500682] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1862; }","duration":"339.430206ms","start":"2026-10-04T05:50:17.690569Z","end":"2026-10-04T05:50:18.029999Z","steps":["trace[1751500682] 'agreement among raft nodes before linearized reading'  (duration: 339.146628ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:50:18.030065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T05:50:17.690553Z","time spent":"339.502518ms","remote":"127.0.0.1:51104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T05:50:18.343177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.828796ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560263928 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1832 > 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:16"}
{"level":"info","ts":"2026-10-04T05:50:18.34348Z","caller":"traceutil/trace.go:171","msg":"trace[1827319493] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"307.776779ms","start":"2026-10-04T05:50:18.035579Z","end":"2026-10-04T05:50:18.343355Z","steps":["trace[1827319493] 'process raft request'  (duration: 117.586163ms)","trace[1827319493] 'compare'  (duration: 189.631901ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:50:18.343718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T05:50:18.035548Z","time spent":"308.074477ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1832 > 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-04T05:50:30.8362Z","caller":"traceutil/trace.go:171","msg":"trace[1329954744] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"140.293029ms","start":"2026-10-04T05:50:30.695866Z","end":"2026-10-04T05:50:30.836159Z","steps":["trace[1329954744] 'process raft request'  (duration: 139.989741ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:50:31.041178Z","caller":"traceutil/trace.go:171","msg":"trace[1407226753] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"156.929258ms","start":"2026-10-04T05:50:30.884205Z","end":"2026-10-04T05:50:31.041135Z","steps":["trace[1407226753] 'process raft request'  (duration: 151.876518ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:51:02.450056Z","caller":"traceutil/trace.go:171","msg":"trace[1676074355] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"124.742482ms","start":"2026-10-04T05:51:02.325278Z","end":"2026-10-04T05:51:02.45002Z","steps":["trace[1676074355] 'process raft request'  (duration: 61.656883ms)","trace[1676074355] 'compare'  (duration: 62.931445ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:51:08.834818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.22619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-04T05:51:08.834904Z","caller":"traceutil/trace.go:171","msg":"trace[1013776817] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2181; }","duration":"191.414585ms","start":"2026-10-04T05:51:08.643471Z","end":"2026-10-04T05:51:08.834886Z","steps":["trace[1013776817] 'range keys from in-memory index tree'  (duration: 191.061176ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:52:33.719444Z","caller":"traceutil/trace.go:171","msg":"trace[1530159912] linearizableReadLoop","detail":"{readStateIndex:2944; appliedIndex:2943; }","duration":"144.854512ms","start":"2026-10-04T05:52:33.574562Z","end":"2026-10-04T05:52:33.719417Z","steps":["trace[1530159912] 'read index received'  (duration: 144.648427ms)","trace[1530159912] 'applied index is now lower than readState.Index'  (duration: 205.265µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:52:33.719615Z","caller":"traceutil/trace.go:171","msg":"trace[1464065919] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"180.974733ms","start":"2026-10-04T05:52:33.538597Z","end":"2026-10-04T05:52:33.719572Z","steps":["trace[1464065919] 'process raft request'  (duration: 180.631044ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:52:33.719848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.154333ms","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-04T05:52:33.7199Z","caller":"traceutil/trace.go:171","msg":"trace[1706141463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2833; }","duration":"123.255346ms","start":"2026-10-04T05:52:33.596634Z","end":"2026-10-04T05:52:33.719889Z","steps":["trace[1706141463] 'agreement among raft nodes before linearized reading'  (duration: 122.988108ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:52:33.719885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.299494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-10-04T05:52:33.720199Z","caller":"traceutil/trace.go:171","msg":"trace[1801519605] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2833; }","duration":"145.672734ms","start":"2026-10-04T05:52:33.574499Z","end":"2026-10-04T05:52:33.720172Z","steps":["trace[1801519605] 'agreement among raft nodes before linearized reading'  (duration: 145.059668ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:56:02.812584Z","caller":"traceutil/trace.go:171","msg":"trace[1522292575] transaction","detail":"{read_only:false; response_revision:4134; number_of_response:1; }","duration":"114.986932ms","start":"2026-10-04T05:56:02.697566Z","end":"2026-10-04T05:56:02.812553Z","steps":["trace[1522292575] 'process raft request'  (duration: 108.148876ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:29.106984Z","caller":"traceutil/trace.go:171","msg":"trace[1265282820] linearizableReadLoop","detail":"{readStateIndex:5306; appliedIndex:5304; }","duration":"117.91057ms","start":"2026-10-04T05:57:28.98905Z","end":"2026-10-04T05:57:29.106961Z","steps":["trace[1265282820] 'read index received'  (duration: 82.002497ms)","trace[1265282820] 'applied index is now lower than readState.Index'  (duration: 35.907103ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:57:29.107103Z","caller":"traceutil/trace.go:171","msg":"trace[1270608275] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"119.601565ms","start":"2026-10-04T05:57:28.987464Z","end":"2026-10-04T05:57:29.107065Z","steps":["trace[1270608275] 'process raft request'  (duration: 119.383099ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:29.107162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.099946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T05:57:29.107222Z","caller":"traceutil/trace.go:171","msg":"trace[1250620467] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:0; response_revision:5109; }","duration":"118.183927ms","start":"2026-10-04T05:57:28.989018Z","end":"2026-10-04T05:57:29.107202Z","steps":["trace[1250620467] 'agreement among raft nodes before linearized reading'  (duration: 118.105295ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:30.042673Z","caller":"traceutil/trace.go:171","msg":"trace[637121480] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"196.330037ms","start":"2026-10-04T05:57:29.84631Z","end":"2026-10-04T05:57:30.04264Z","steps":["trace[637121480] 'process raft request'  (duration: 135.461062ms)","trace[637121480] 'compare'  (duration: 60.602358ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:57:30.042937Z","caller":"traceutil/trace.go:171","msg":"trace[1507150687] linearizableReadLoop","detail":"{readStateIndex:5344; appliedIndex:5342; }","duration":"114.793771ms","start":"2026-10-04T05:57:29.928128Z","end":"2026-10-04T05:57:30.042921Z","steps":["trace[1507150687] 'read index received'  (duration: 55.019004ms)","trace[1507150687] 'applied index is now lower than readState.Index'  (duration: 59.770237ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:57:30.043049Z","caller":"traceutil/trace.go:171","msg":"trace[1186952841] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"124.663054ms","start":"2026-10-04T05:57:29.918355Z","end":"2026-10-04T05:57:30.043018Z","steps":["trace[1186952841] 'process raft request'  (duration: 124.205983ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:30.043096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.949034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T05:57:30.043146Z","caller":"traceutil/trace.go:171","msg":"trace[817735167] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:5147; }","duration":"115.043297ms","start":"2026-10-04T05:57:29.928088Z","end":"2026-10-04T05:57:30.043131Z","steps":["trace[817735167] 'agreement among raft nodes before linearized reading'  (duration: 114.940714ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:32.122604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.25986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T05:57:32.122708Z","caller":"traceutil/trace.go:171","msg":"trace[2143116389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5194; }","duration":"169.439844ms","start":"2026-10-04T05:57:31.953249Z","end":"2026-10-04T05:57:32.122688Z","steps":["trace[2143116389] 'range keys from in-memory index tree'  (duration: 169.180108ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:32.185337Z","caller":"traceutil/trace.go:171","msg":"trace[41013694] linearizableReadLoop","detail":"{readStateIndex:5394; appliedIndex:5393; }","duration":"156.538693ms","start":"2026-10-04T05:57:32.028763Z","end":"2026-10-04T05:57:32.185301Z","steps":["trace[41013694] 'read index received'  (duration: 84.549172ms)","trace[41013694] 'applied index is now lower than readState.Index'  (duration: 71.986381ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:57:32.185464Z","caller":"traceutil/trace.go:171","msg":"trace[84787667] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"136.791296ms","start":"2026-10-04T05:57:32.048625Z","end":"2026-10-04T05:57:32.185416Z","steps":["trace[84787667] 'process raft request'  (duration: 136.600881ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:32.186332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.55471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210289"}
{"level":"info","ts":"2026-10-04T05:57:32.186415Z","caller":"traceutil/trace.go:171","msg":"trace[1757389389] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:5195; }","duration":"157.700293ms","start":"2026-10-04T05:57:32.028697Z","end":"2026-10-04T05:57:32.186398Z","steps":["trace[1757389389] 'agreement among raft nodes before linearized reading'  (duration: 156.765849ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:36.215238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.154959ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560272574 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2aff548-8b88-4ae3-997a-dea83a64715b\" mod_revision:5342 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2aff548-8b88-4ae3-997a-dea83a64715b\" value_size:3602 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2aff548-8b88-4ae3-997a-dea83a64715b\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T05:57:36.215377Z","caller":"traceutil/trace.go:171","msg":"trace[388469172] linearizableReadLoop","detail":"{readStateIndex:5578; appliedIndex:5577; }","duration":"267.458994ms","start":"2026-10-04T05:57:35.947896Z","end":"2026-10-04T05:57:36.215355Z","steps":["trace[388469172] 'read index received'  (duration: 145.12088ms)","trace[388469172] 'applied index is now lower than readState.Index'  (duration: 122.336044ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:57:36.215489Z","caller":"traceutil/trace.go:171","msg":"trace[999421323] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"276.758243ms","start":"2026-10-04T05:57:35.938712Z","end":"2026-10-04T05:57:36.215471Z","steps":["trace[999421323] 'process raft request'  (duration: 154.262245ms)","trace[999421323] 'compare'  (duration: 121.975685ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:57:36.216199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.296707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786893"}
{"level":"info","ts":"2026-10-04T05:57:36.216272Z","caller":"traceutil/trace.go:171","msg":"trace[1188982908] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5375; }","duration":"268.4122ms","start":"2026-10-04T05:57:35.947841Z","end":"2026-10-04T05:57:36.216253Z","steps":["trace[1188982908] 'agreement among raft nodes before linearized reading'  (duration: 267.811843ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:36.290795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.842517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2aff548-8b88-4ae3-997a-dea83a64715b\" ","response":"range_response_count:1 size:3717"}
{"level":"info","ts":"2026-10-04T05:57:36.290893Z","caller":"traceutil/trace.go:171","msg":"trace[76190311] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e2aff548-8b88-4ae3-997a-dea83a64715b; range_end:; response_count:1; response_revision:5376; }","duration":"329.99131ms","start":"2026-10-04T05:57:35.960879Z","end":"2026-10-04T05:57:36.29087Z","steps":["trace[76190311] 'agreement among raft nodes before linearized reading'  (duration: 329.815346ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:36.290934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T05:57:35.960859Z","time spent":"330.065863ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3741,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2aff548-8b88-4ae3-997a-dea83a64715b\" "}
{"level":"warn","ts":"2026-10-04T05:57:36.29153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.252789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-z9qrn-tls\" ","response":"range_response_count:1 size:2183"}
{"level":"info","ts":"2026-10-04T05:57:36.291695Z","caller":"traceutil/trace.go:171","msg":"trace[1852960281] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-z9qrn-tls; range_end:; response_count:1; response_revision:5376; }","duration":"274.444934ms","start":"2026-10-04T05:57:36.017237Z","end":"2026-10-04T05:57:36.291682Z","steps":["trace[1852960281] 'agreement among raft nodes before linearized reading'  (duration: 274.169017ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:44.134709Z","caller":"traceutil/trace.go:171","msg":"trace[108289458] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"106.555789ms","start":"2026-10-04T05:57:44.028117Z","end":"2026-10-04T05:57:44.134673Z","steps":["trace[108289458] 'process raft request'  (duration: 106.414206ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:44.134763Z","caller":"traceutil/trace.go:171","msg":"trace[850438521] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"108.470048ms","start":"2026-10-04T05:57:44.02626Z","end":"2026-10-04T05:57:44.13473Z","steps":["trace[850438521] 'process raft request'  (duration: 84.242245ms)","trace[850438521] 'compare'  (duration: 23.795422ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:57:50.240345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.524116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-hqdrb\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-10-04T05:57:50.240467Z","caller":"traceutil/trace.go:171","msg":"trace[1615223920] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-hqdrb; range_end:; response_count:1; response_revision:5624; }","duration":"125.643319ms","start":"2026-10-04T05:57:50.114779Z","end":"2026-10-04T05:57:50.240422Z","steps":["trace[1615223920] 'range keys from in-memory index tree'  (duration: 125.241689ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:50.550532Z","caller":"traceutil/trace.go:171","msg":"trace[1075343324] linearizableReadLoop","detail":"{readStateIndex:5842; appliedIndex:5841; }","duration":"112.750929ms","start":"2026-10-04T05:57:50.437743Z","end":"2026-10-04T05:57:50.550493Z","steps":["trace[1075343324] 'read index received'  (duration: 82.530072ms)","trace[1075343324] 'applied index is now lower than readState.Index'  (duration: 30.219917ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T05:57:50.550611Z","caller":"traceutil/trace.go:171","msg":"trace[1755627254] transaction","detail":"{read_only:false; response_revision:5631; number_of_response:1; }","duration":"182.4316ms","start":"2026-10-04T05:57:50.368137Z","end":"2026-10-04T05:57:50.550568Z","steps":["trace[1755627254] 'process raft request'  (duration: 152.224403ms)","trace[1755627254] 'compare'  (duration: 29.99302ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T05:57:50.550748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.977294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18116"}
{"level":"info","ts":"2026-10-04T05:57:50.5508Z","caller":"traceutil/trace.go:171","msg":"trace[2005611562] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5631; }","duration":"113.074687ms","start":"2026-10-04T05:57:50.437714Z","end":"2026-10-04T05:57:50.550789Z","steps":["trace[2005611562] 'agreement among raft nodes before linearized reading'  (duration: 112.891633ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T05:57:53.390052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2942}
{"level":"info","ts":"2026-10-04T05:57:53.461121Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2942,"took":"69.783684ms","hash":2513035201,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":31191040,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T05:57:53.461212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2513035201,"revision":2942,"compact-revision":-1}
{"level":"info","ts":"2026-10-04T05:57:58.694206Z","caller":"traceutil/trace.go:171","msg":"trace[411171810] transaction","detail":"{read_only:false; response_revision:5837; number_of_response:1; }","duration":"306.721393ms","start":"2026-10-04T05:57:58.387466Z","end":"2026-10-04T05:57:58.694187Z","steps":["trace[411171810] 'process raft request'  (duration: 306.59376ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T05:57:58.694337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T05:57:58.387449Z","time spent":"306.819556ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5734 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T06:02:53.398715Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5705}
{"level":"info","ts":"2026-10-04T06:02:53.489674Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5705,"took":"88.899025ms","hash":2349920752,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":26476544,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-04T06:02:53.489793Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2349920752,"revision":5705,"compact-revision":2942}
{"level":"warn","ts":"2026-10-04T06:04:24.993682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.856228ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560281366 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8721 > 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:16"}
{"level":"info","ts":"2026-10-04T06:04:24.993867Z","caller":"traceutil/trace.go:171","msg":"trace[2106533165] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"230.074292ms","start":"2026-10-04T06:04:24.763769Z","end":"2026-10-04T06:04:24.993843Z","steps":["trace[2106533165] 'process raft request'  (duration: 99.962628ms)","trace[2106533165] 'compare'  (duration: 129.455006ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:04:25.809897Z","caller":"traceutil/trace.go:171","msg":"trace[990194681] linearizableReadLoop","detail":"{readStateIndex:9041; appliedIndex:9040; }","duration":"160.678678ms","start":"2026-10-04T06:04:25.649172Z","end":"2026-10-04T06:04:25.809851Z","steps":["trace[990194681] 'read index received'  (duration: 160.553675ms)","trace[990194681] 'applied index is now lower than readState.Index'  (duration: 124.023µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:04:25.810027Z","caller":"traceutil/trace.go:171","msg":"trace[643779385] transaction","detail":"{read_only:false; response_revision:8732; number_of_response:1; }","duration":"161.49181ms","start":"2026-10-04T06:04:25.648497Z","end":"2026-10-04T06:04:25.809989Z","steps":["trace[643779385] 'process raft request'  (duration: 161.206732ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:04:25.810198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.015397ms","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-04T06:04:25.810233Z","caller":"traceutil/trace.go:171","msg":"trace[36238948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8732; }","duration":"161.093389ms","start":"2026-10-04T06:04:25.649132Z","end":"2026-10-04T06:04:25.810225Z","steps":["trace[36238948] 'agreement among raft nodes before linearized reading'  (duration: 160.852752ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:04:25.810242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.001398ms","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-04T06:04:25.810321Z","caller":"traceutil/trace.go:171","msg":"trace[1835846873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8732; }","duration":"149.114752ms","start":"2026-10-04T06:04:25.66119Z","end":"2026-10-04T06:04:25.810305Z","steps":["trace[1835846873] 'agreement among raft nodes before linearized reading'  (duration: 148.821674ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:04:25.810373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.974359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-04T06:04:25.810399Z","caller":"traceutil/trace.go:171","msg":"trace[699039454] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8732; }","duration":"144.01738ms","start":"2026-10-04T06:04:25.666374Z","end":"2026-10-04T06:04:25.810392Z","steps":["trace[699039454] 'agreement among raft nodes before linearized reading'  (duration: 143.955238ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:04:25.810446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.628135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-04T06:04:25.810522Z","caller":"traceutil/trace.go:171","msg":"trace[1638742798] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8732; }","duration":"135.782779ms","start":"2026-10-04T06:04:25.674721Z","end":"2026-10-04T06:04:25.810504Z","steps":["trace[1638742798] 'agreement among raft nodes before linearized reading'  (duration: 135.522962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:04:26.403801Z","caller":"traceutil/trace.go:171","msg":"trace[1549533650] transaction","detail":"{read_only:false; response_revision:8737; number_of_response:1; }","duration":"170.334587ms","start":"2026-10-04T06:04:26.233439Z","end":"2026-10-04T06:04:26.403774Z","steps":["trace[1549533650] 'process raft request'  (duration: 170.09143ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:04:26.568052Z","caller":"traceutil/trace.go:171","msg":"trace[1544444875] transaction","detail":"{read_only:false; response_revision:8738; number_of_response:1; }","duration":"189.804957ms","start":"2026-10-04T06:04:26.378222Z","end":"2026-10-04T06:04:26.568027Z","steps":["trace[1544444875] 'process raft request'  (duration: 103.233373ms)","trace[1544444875] 'compare'  (duration: 86.479982ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:04:55.15985Z","caller":"traceutil/trace.go:171","msg":"trace[489774292] transaction","detail":"{read_only:false; response_revision:8947; number_of_response:1; }","duration":"129.761522ms","start":"2026-10-04T06:04:55.030038Z","end":"2026-10-04T06:04:55.1598Z","steps":["trace[489774292] 'process raft request'  (duration: 129.612008ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:04:55.362434Z","caller":"traceutil/trace.go:171","msg":"trace[1446806547] linearizableReadLoop","detail":"{readStateIndex:9265; appliedIndex:9263; }","duration":"227.612675ms","start":"2026-10-04T06:04:55.13475Z","end":"2026-10-04T06:04:55.362362Z","steps":["trace[1446806547] 'read index received'  (duration: 24.898779ms)","trace[1446806547] 'applied index is now lower than readState.Index'  (duration: 202.711706ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:04:55.362603Z","caller":"traceutil/trace.go:171","msg":"trace[1963599925] transaction","detail":"{read_only:false; response_revision:8948; number_of_response:1; }","duration":"258.580031ms","start":"2026-10-04T06:04:55.104005Z","end":"2026-10-04T06:04:55.362585Z","steps":["trace[1963599925] 'process raft request'  (duration: 231.733071ms)","trace[1963599925] 'compare'  (duration: 26.387308ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:04:55.362962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.18986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-10-04T06:04:55.363038Z","caller":"traceutil/trace.go:171","msg":"trace[1388845386] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8948; }","duration":"228.305963ms","start":"2026-10-04T06:04:55.134715Z","end":"2026-10-04T06:04:55.363021Z","steps":["trace[1388845386] 'agreement among raft nodes before linearized reading'  (duration: 227.876112ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:04:57.513798Z","caller":"traceutil/trace.go:171","msg":"trace[1754793092] linearizableReadLoop","detail":"{readStateIndex:9277; appliedIndex:9276; }","duration":"137.925321ms","start":"2026-10-04T06:04:57.375845Z","end":"2026-10-04T06:04:57.51377Z","steps":["trace[1754793092] 'read index received'  (duration: 71.919807ms)","trace[1754793092] 'applied index is now lower than readState.Index'  (duration: 66.004624ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:04:57.513897Z","caller":"traceutil/trace.go:171","msg":"trace[1708153557] transaction","detail":"{read_only:false; response_revision:8959; number_of_response:1; }","duration":"146.483162ms","start":"2026-10-04T06:04:57.36738Z","end":"2026-10-04T06:04:57.513863Z","steps":["trace[1708153557] 'process raft request'  (duration: 80.434866ms)","trace[1708153557] 'compare'  (duration: 65.854521ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:04:57.514072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.218849ms","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-04T06:04:57.514133Z","caller":"traceutil/trace.go:171","msg":"trace[455188841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8959; }","duration":"138.321402ms","start":"2026-10-04T06:04:57.375793Z","end":"2026-10-04T06:04:57.514114Z","steps":["trace[455188841] 'agreement among raft nodes before linearized reading'  (duration: 138.141617ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:05:04.611296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.170954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T06:05:04.611395Z","caller":"traceutil/trace.go:171","msg":"trace[1349810806] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:8999; }","duration":"225.327598ms","start":"2026-10-04T06:05:04.386047Z","end":"2026-10-04T06:05:04.611375Z","steps":["trace[1349810806] 'count revisions from in-memory index tree'  (duration: 225.062591ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:05:04.611358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.700282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T06:05:04.611594Z","caller":"traceutil/trace.go:171","msg":"trace[652139563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8999; }","duration":"182.906707ms","start":"2026-10-04T06:05:04.428608Z","end":"2026-10-04T06:05:04.611515Z","steps":["trace[652139563] 'range keys from in-memory index tree'  (duration: 182.63292ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:05:24.22646Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002539.wal"}
{"level":"info","ts":"2026-10-04T06:06:09.046728Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca4c710a8d5349d7","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T06:06:09.058174Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-04T06:06:09.058308Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-04T06:06:34.312108Z","caller":"traceutil/trace.go:171","msg":"trace[1954113128] linearizableReadLoop","detail":"{readStateIndex:10205; appliedIndex:10204; }","duration":"119.049648ms","start":"2026-10-04T06:06:34.193028Z","end":"2026-10-04T06:06:34.312078Z","steps":["trace[1954113128] 'read index received'  (duration: 116.478751ms)","trace[1954113128] 'applied index is now lower than readState.Index'  (duration: 2.569697ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:06:34.312186Z","caller":"traceutil/trace.go:171","msg":"trace[23355533] transaction","detail":"{read_only:false; response_revision:9860; number_of_response:1; }","duration":"239.11307ms","start":"2026-10-04T06:06:34.073041Z","end":"2026-10-04T06:06:34.312154Z","steps":["trace[23355533] 'process raft request'  (duration: 236.455132ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:06:34.312271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.219142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T06:06:34.312304Z","caller":"traceutil/trace.go:171","msg":"trace[1485449630] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:9860; }","duration":"119.306715ms","start":"2026-10-04T06:06:34.192985Z","end":"2026-10-04T06:06:34.312292Z","steps":["trace[1485449630] 'agreement among raft nodes before linearized reading'  (duration: 119.229833ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:06:34.312486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.586254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:20018"}
{"level":"info","ts":"2026-10-04T06:06:34.312559Z","caller":"traceutil/trace.go:171","msg":"trace[110690451] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9860; }","duration":"102.666366ms","start":"2026-10-04T06:06:34.209873Z","end":"2026-10-04T06:06:34.312539Z","steps":["trace[110690451] 'agreement among raft nodes before linearized reading'  (duration: 102.450491ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:07:53.406311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8016}
{"level":"info","ts":"2026-10-04T06:07:53.476339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8016,"took":"68.062118ms","hash":734131949,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":28172288,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T06:07:53.476444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":734131949,"revision":8016,"compact-revision":5705}
{"level":"info","ts":"2026-10-04T06:10:20.559206Z","caller":"traceutil/trace.go:171","msg":"trace[2009969965] transaction","detail":"{read_only:false; response_revision:11720; number_of_response:1; }","duration":"131.831915ms","start":"2026-10-04T06:10:20.427348Z","end":"2026-10-04T06:10:20.55918Z","steps":["trace[2009969965] 'process raft request'  (duration: 131.671151ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:12:53.413322Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10410}
{"level":"info","ts":"2026-10-04T06:12:53.507778Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10410,"took":"90.558315ms","hash":820791570,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":27713536,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T06:12:53.507848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":820791570,"revision":10410,"compact-revision":8016}
{"level":"info","ts":"2026-10-04T06:16:31.633556Z","caller":"traceutil/trace.go:171","msg":"trace[424802096] transaction","detail":"{read_only:false; response_revision:14217; number_of_response:1; }","duration":"230.088035ms","start":"2026-10-04T06:16:31.403436Z","end":"2026-10-04T06:16:31.633524Z","steps":["trace[424802096] 'process raft request'  (duration: 132.153172ms)","trace[424802096] 'compare'  (duration: 97.80228ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:17:53.423161Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12748}
{"level":"info","ts":"2026-10-04T06:17:53.508593Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12748,"took":"81.226755ms","hash":660055487,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":30629888,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T06:17:53.508641Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":660055487,"revision":12748,"compact-revision":10410}
{"level":"info","ts":"2026-10-04T06:18:08.600983Z","caller":"traceutil/trace.go:171","msg":"trace[419371132] transaction","detail":"{read_only:false; response_revision:15424; number_of_response:1; }","duration":"128.893208ms","start":"2026-10-04T06:18:08.472066Z","end":"2026-10-04T06:18:08.600959Z","steps":["trace[419371132] 'process raft request'  (duration: 121.707865ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:18:08.601181Z","caller":"traceutil/trace.go:171","msg":"trace[795494243] linearizableReadLoop","detail":"{readStateIndex:15945; appliedIndex:15944; }","duration":"116.819479ms","start":"2026-10-04T06:18:08.48435Z","end":"2026-10-04T06:18:08.60117Z","steps":["trace[795494243] 'read index received'  (duration: 109.44163ms)","trace[795494243] 'applied index is now lower than readState.Index'  (duration: 7.376929ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:18:08.601424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.059695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-04T06:18:08.601458Z","caller":"traceutil/trace.go:171","msg":"trace[468875760] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15425; }","duration":"117.140327ms","start":"2026-10-04T06:18:08.484305Z","end":"2026-10-04T06:18:08.601446Z","steps":["trace[468875760] 'agreement among raft nodes before linearized reading'  (duration: 117.023704ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:18:26.396691Z","caller":"traceutil/trace.go:171","msg":"trace[1099503656] transaction","detail":"{read_only:false; response_revision:15516; number_of_response:1; }","duration":"121.988792ms","start":"2026-10-04T06:18:26.274669Z","end":"2026-10-04T06:18:26.396658Z","steps":["trace[1099503656] 'process raft request'  (duration: 102.43716ms)","trace[1099503656] 'compare'  (duration: 19.280444ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:18:26.396858Z","caller":"traceutil/trace.go:171","msg":"trace[1991600908] linearizableReadLoop","detail":"{readStateIndex:16040; appliedIndex:16039; }","duration":"116.581763ms","start":"2026-10-04T06:18:26.280247Z","end":"2026-10-04T06:18:26.396829Z","steps":["trace[1991600908] 'read index received'  (duration: 96.794945ms)","trace[1991600908] 'applied index is now lower than readState.Index'  (duration: 19.784238ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:18:26.397049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.792308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-04T06:18:26.397093Z","caller":"traceutil/trace.go:171","msg":"trace[1170835071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15517; }","duration":"116.918471ms","start":"2026-10-04T06:18:26.280163Z","end":"2026-10-04T06:18:26.397082Z","steps":["trace[1170835071] 'agreement among raft nodes before linearized reading'  (duration: 116.767878ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:18:31.926536Z","caller":"traceutil/trace.go:171","msg":"trace[897418064] transaction","detail":"{read_only:false; response_revision:15545; number_of_response:1; }","duration":"108.417623ms","start":"2026-10-04T06:18:31.818082Z","end":"2026-10-04T06:18:31.9265Z","steps":["trace[897418064] 'process raft request'  (duration: 108.178946ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:18:32.255972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.042221ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560300994 > lease_revoke:<id:49d7a10574570be1>","response":"size:29"}
{"level":"info","ts":"2026-10-04T06:18:32.256114Z","caller":"traceutil/trace.go:171","msg":"trace[1171505462] linearizableReadLoop","detail":"{readStateIndex:16071; appliedIndex:16070; }","duration":"172.2276ms","start":"2026-10-04T06:18:32.083858Z","end":"2026-10-04T06:18:32.256086Z","steps":["trace[1171505462] 'read index received'  (duration: 36.621µs)","trace[1171505462] 'applied index is now lower than readState.Index'  (duration: 172.189189ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:18:32.256355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.493367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-nskj8\" ","response":"range_response_count:1 size:9798"}
{"level":"info","ts":"2026-10-04T06:18:32.256414Z","caller":"traceutil/trace.go:171","msg":"trace[783178564] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-nskj8; range_end:; response_count:1; response_revision:15545; }","duration":"172.582259ms","start":"2026-10-04T06:18:32.083816Z","end":"2026-10-04T06:18:32.256398Z","steps":["trace[783178564] 'agreement among raft nodes before linearized reading'  (duration: 172.338033ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:18:33.312951Z","caller":"traceutil/trace.go:171","msg":"trace[284145616] linearizableReadLoop","detail":"{readStateIndex:16080; appliedIndex:16079; }","duration":"166.77569ms","start":"2026-10-04T06:18:33.14615Z","end":"2026-10-04T06:18:33.312926Z","steps":["trace[284145616] 'read index received'  (duration: 166.359869ms)","trace[284145616] 'applied index is now lower than readState.Index'  (duration: 414.951µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:18:33.313182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.025788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6t78l\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-04T06:18:33.313247Z","caller":"traceutil/trace.go:171","msg":"trace[1906264913] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6t78l; range_end:; response_count:1; response_revision:15554; }","duration":"167.164511ms","start":"2026-10-04T06:18:33.146071Z","end":"2026-10-04T06:18:33.313236Z","steps":["trace[1906264913] 'agreement among raft nodes before linearized reading'  (duration: 166.965245ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:18:33.313651Z","caller":"traceutil/trace.go:171","msg":"trace[613498045] transaction","detail":"{read_only:false; response_revision:15554; number_of_response:1; }","duration":"244.219298ms","start":"2026-10-04T06:18:33.069414Z","end":"2026-10-04T06:18:33.313633Z","steps":["trace[613498045] 'process raft request'  (duration: 243.234742ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:22:53.431497Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15257}
{"level":"info","ts":"2026-10-04T06:22:53.534515Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15257,"took":"100.019046ms","hash":404438214,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":31248384,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T06:22:53.53458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":404438214,"revision":15257,"compact-revision":12748}
{"level":"warn","ts":"2026-10-04T06:24:24.020467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.955021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/rabbitmq-heat-nodes\" ","response":"range_response_count:1 size:948"}
{"level":"warn","ts":"2026-10-04T06:24:24.020531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.628718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3226"}
{"level":"info","ts":"2026-10-04T06:24:24.020571Z","caller":"traceutil/trace.go:171","msg":"trace[1257389527] range","detail":"{range_begin:/registry/services/endpoints/openstack/rabbitmq-heat-nodes; range_end:; response_count:1; response_revision:18216; }","duration":"130.101355ms","start":"2026-10-04T06:24:23.890446Z","end":"2026-10-04T06:24:24.020547Z","steps":["trace[1257389527] 'range keys from in-memory index tree'  (duration: 129.784147ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:24:24.020611Z","caller":"traceutil/trace.go:171","msg":"trace[893526127] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18216; }","duration":"169.763731ms","start":"2026-10-04T06:24:23.850827Z","end":"2026-10-04T06:24:24.020591Z","steps":["trace[893526127] 'range keys from in-memory index tree'  (duration: 169.403942ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:24:24.375872Z","caller":"traceutil/trace.go:171","msg":"trace[773374739] linearizableReadLoop","detail":"{readStateIndex:18836; appliedIndex:18835; }","duration":"258.548168ms","start":"2026-10-04T06:24:24.117287Z","end":"2026-10-04T06:24:24.375835Z","steps":["trace[773374739] 'read index received'  (duration: 258.411265ms)","trace[773374739] 'applied index is now lower than readState.Index'  (duration: 135.833µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:24:24.376058Z","caller":"traceutil/trace.go:171","msg":"trace[293129469] transaction","detail":"{read_only:false; response_revision:18222; number_of_response:1; }","duration":"260.797475ms","start":"2026-10-04T06:24:24.115201Z","end":"2026-10-04T06:24:24.375999Z","steps":["trace[293129469] 'process raft request'  (duration: 260.470097ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:24:24.37614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.830625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-10-04T06:24:24.376269Z","caller":"traceutil/trace.go:171","msg":"trace[395742059] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:18222; }","duration":"258.995919ms","start":"2026-10-04T06:24:24.117254Z","end":"2026-10-04T06:24:24.37625Z","steps":["trace[395742059] 'agreement among raft nodes before linearized reading'  (duration: 258.739882ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:24:24.6612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.242991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-10-04T06:24:24.661284Z","caller":"traceutil/trace.go:171","msg":"trace[1767800780] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:18224; }","duration":"173.395225ms","start":"2026-10-04T06:24:24.487867Z","end":"2026-10-04T06:24:24.661263Z","steps":["trace[1767800780] 'range keys from in-memory index tree'  (duration: 173.051156ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:24:24.661329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.471012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:24:24.66141Z","caller":"traceutil/trace.go:171","msg":"trace[1969522874] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:18224; }","duration":"197.587715ms","start":"2026-10-04T06:24:24.463801Z","end":"2026-10-04T06:24:24.661389Z","steps":["trace[1969522874] 'count revisions from in-memory index tree'  (duration: 197.39494ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:24:24.661486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.113368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T06:24:24.661558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.992854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-heat.18db3f7522a85f01\" ","response":"range_response_count:1 size:739"}
{"level":"info","ts":"2026-10-04T06:24:24.661657Z","caller":"traceutil/trace.go:171","msg":"trace[2140724819] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-heat.18db3f7522a85f01; range_end:; response_count:1; response_revision:18224; }","duration":"196.129538ms","start":"2026-10-04T06:24:24.465505Z","end":"2026-10-04T06:24:24.661635Z","steps":["trace[2140724819] 'range keys from in-memory index tree'  (duration: 195.787739ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:24:24.661592Z","caller":"traceutil/trace.go:171","msg":"trace[1570909305] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18224; }","duration":"173.280782ms","start":"2026-10-04T06:24:24.488282Z","end":"2026-10-04T06:24:24.661563Z","steps":["trace[1570909305] 'range keys from in-memory index tree'  (duration: 172.826751ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:26:32.442579Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca4c710a8d5349d7","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T06:26:32.448856Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-04T06:26:32.44912Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-04T06:27:53.438418Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17480}
{"level":"info","ts":"2026-10-04T06:27:53.54167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17480,"took":"100.042444ms","hash":2687388145,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":34922496,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-04T06:27:53.541746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2687388145,"revision":17480,"compact-revision":15257}
{"level":"info","ts":"2026-10-04T06:29:46.613674Z","caller":"traceutil/trace.go:171","msg":"trace[1666927792] transaction","detail":"{read_only:false; response_revision:20690; number_of_response:1; }","duration":"114.375171ms","start":"2026-10-04T06:29:46.499274Z","end":"2026-10-04T06:29:46.613649Z","steps":["trace[1666927792] 'process raft request'  (duration: 114.171426ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:29:46.82167Z","caller":"traceutil/trace.go:171","msg":"trace[851876328] linearizableReadLoop","detail":"{readStateIndex:21388; appliedIndex:21387; }","duration":"175.100049ms","start":"2026-10-04T06:29:46.646527Z","end":"2026-10-04T06:29:46.821627Z","steps":["trace[851876328] 'read index received'  (duration: 162.649399ms)","trace[851876328] 'applied index is now lower than readState.Index'  (duration: 12.44883ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:29:46.821693Z","caller":"traceutil/trace.go:171","msg":"trace[1124497688] transaction","detail":"{read_only:false; response_revision:20691; number_of_response:1; }","duration":"285.678674ms","start":"2026-10-04T06:29:46.535954Z","end":"2026-10-04T06:29:46.821633Z","steps":["trace[1124497688] 'process raft request'  (duration: 273.264455ms)","trace[1124497688] 'compare'  (duration: 12.116041ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:29:46.821803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.251173ms","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-04T06:29:46.821892Z","caller":"traceutil/trace.go:171","msg":"trace[360407365] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20691; }","duration":"175.387897ms","start":"2026-10-04T06:29:46.646484Z","end":"2026-10-04T06:29:46.821872Z","steps":["trace[360407365] 'agreement among raft nodes before linearized reading'  (duration: 175.254733ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:29:47.103094Z","caller":"traceutil/trace.go:171","msg":"trace[146691490] transaction","detail":"{read_only:false; response_revision:20692; number_of_response:1; }","duration":"276.325874ms","start":"2026-10-04T06:29:46.82674Z","end":"2026-10-04T06:29:47.103066Z","steps":["trace[146691490] 'process raft request'  (duration: 190.292518ms)","trace[146691490] 'compare'  (duration: 85.929954ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:29:47.11607Z","caller":"traceutil/trace.go:171","msg":"trace[882919774] linearizableReadLoop","detail":"{readStateIndex:21390; appliedIndex:21388; }","duration":"177.153191ms","start":"2026-10-04T06:29:46.938892Z","end":"2026-10-04T06:29:47.116045Z","steps":["trace[882919774] 'read index received'  (duration: 78.157473ms)","trace[882919774] 'applied index is now lower than readState.Index'  (duration: 98.994408ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:29:47.116181Z","caller":"traceutil/trace.go:171","msg":"trace[856862772] transaction","detail":"{read_only:false; response_revision:20693; number_of_response:1; }","duration":"217.358602ms","start":"2026-10-04T06:29:46.898788Z","end":"2026-10-04T06:29:47.116146Z","steps":["trace[856862772] 'process raft request'  (duration: 217.095655ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:29:47.116352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.444058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.84\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-10-04T06:29:47.116451Z","caller":"traceutil/trace.go:171","msg":"trace[1107720326] range","detail":"{range_begin:/registry/masterleases/162.253.55.84; range_end:; response_count:1; response_revision:20693; }","duration":"177.595522ms","start":"2026-10-04T06:29:46.938838Z","end":"2026-10-04T06:29:47.116434Z","steps":["trace[1107720326] 'agreement among raft nodes before linearized reading'  (duration: 177.334386ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:29:47.202843Z","caller":"traceutil/trace.go:171","msg":"trace[67272699] transaction","detail":"{read_only:false; response_revision:20694; number_of_response:1; }","duration":"145.258624ms","start":"2026-10-04T06:29:47.057548Z","end":"2026-10-04T06:29:47.202807Z","steps":["trace[67272699] 'process raft request'  (duration: 145.075889ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:29:47.388124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.281333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:29:47.388211Z","caller":"traceutil/trace.go:171","msg":"trace[1495773919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20694; }","duration":"434.449838ms","start":"2026-10-04T06:29:46.953738Z","end":"2026-10-04T06:29:47.388188Z","steps":["trace[1495773919] 'agreement among raft nodes before linearized reading'  (duration: 249.213339ms)","trace[1495773919] 'range keys from in-memory index tree'  (duration: 185.100926ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:29:47.388254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:29:46.953727Z","time spent":"434.518869ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-04T06:29:47.388238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.697295ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560318634 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:49d7a105745752a9>","response":"size:42"}
{"level":"info","ts":"2026-10-04T06:29:47.38833Z","caller":"traceutil/trace.go:171","msg":"trace[748974651] linearizableReadLoop","detail":"{readStateIndex:21392; appliedIndex:21391; }","duration":"185.564907ms","start":"2026-10-04T06:29:47.202748Z","end":"2026-10-04T06:29:47.388313Z","steps":["trace[748974651] 'read index received'  (duration: 710.458µs)","trace[748974651] 'applied index is now lower than readState.Index'  (duration: 184.852919ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:29:47.388442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.90864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:29:47.388474Z","caller":"traceutil/trace.go:171","msg":"trace[1676586608] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:20694; }","duration":"217.008343ms","start":"2026-10-04T06:29:47.171454Z","end":"2026-10-04T06:29:47.388462Z","steps":["trace[1676586608] 'agreement among raft nodes before linearized reading'  (duration: 216.91078ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:29:47.602534Z","caller":"traceutil/trace.go:171","msg":"trace[1080114357] linearizableReadLoop","detail":"{readStateIndex:21394; appliedIndex:21393; }","duration":"179.923602ms","start":"2026-10-04T06:29:47.422588Z","end":"2026-10-04T06:29:47.602512Z","steps":["trace[1080114357] 'read index received'  (duration: 179.755287ms)","trace[1080114357] 'applied index is now lower than readState.Index'  (duration: 167.025µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:29:47.602578Z","caller":"traceutil/trace.go:171","msg":"trace[818105056] transaction","detail":"{read_only:false; response_revision:20696; number_of_response:1; }","duration":"184.634982ms","start":"2026-10-04T06:29:47.417905Z","end":"2026-10-04T06:29:47.60254Z","steps":["trace[818105056] 'process raft request'  (duration: 184.440417ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:29:47.602758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.156988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-10-04T06:29:47.602796Z","caller":"traceutil/trace.go:171","msg":"trace[1499465755] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:20696; }","duration":"180.235681ms","start":"2026-10-04T06:29:47.42255Z","end":"2026-10-04T06:29:47.602786Z","steps":["trace[1499465755] 'agreement among raft nodes before linearized reading'  (duration: 180.045795ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:29:47.861489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.453922ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:29:47.861668Z","caller":"traceutil/trace.go:171","msg":"trace[1204645550] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:20696; }","duration":"151.620096ms","start":"2026-10-04T06:29:47.709988Z","end":"2026-10-04T06:29:47.861608Z","steps":["trace[1204645550] 'range keys from in-memory index tree'  (duration: 151.430092ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:32:53.444948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19912}
{"level":"info","ts":"2026-10-04T06:32:53.577973Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19912,"took":"129.293197ms","hash":1227968420,"current-db-size-bytes":55697408,"current-db-size":"56 MB","current-db-size-in-use-bytes":30527488,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-04T06:32:53.578054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1227968420,"revision":19912,"compact-revision":17480}
{"level":"info","ts":"2026-10-04T06:33:42.328957Z","caller":"traceutil/trace.go:171","msg":"trace[1976366700] transaction","detail":"{read_only:false; response_revision:23149; number_of_response:1; }","duration":"206.047277ms","start":"2026-10-04T06:33:42.122871Z","end":"2026-10-04T06:33:42.328919Z","steps":["trace[1976366700] 'process raft request'  (duration: 183.075187ms)","trace[1976366700] 'compare'  (duration: 22.396655ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:36:58.252979Z","caller":"traceutil/trace.go:171","msg":"trace[1205444109] transaction","detail":"{read_only:false; response_revision:25182; number_of_response:1; }","duration":"134.801468ms","start":"2026-10-04T06:36:58.118151Z","end":"2026-10-04T06:36:58.252953Z","steps":["trace[1205444109] 'process raft request'  (duration: 134.638554ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:36:58.350471Z","caller":"traceutil/trace.go:171","msg":"trace[513509501] linearizableReadLoop","detail":"{readStateIndex:26001; appliedIndex:25999; }","duration":"106.302778ms","start":"2026-10-04T06:36:58.244146Z","end":"2026-10-04T06:36:58.350449Z","steps":["trace[513509501] 'read index received'  (duration: 8.696723ms)","trace[513509501] 'applied index is now lower than readState.Index'  (duration: 97.605085ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:36:58.350644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.487322ms","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-04T06:36:58.350681Z","caller":"traceutil/trace.go:171","msg":"trace[1062615313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25183; }","duration":"106.575774ms","start":"2026-10-04T06:36:58.244095Z","end":"2026-10-04T06:36:58.350671Z","steps":["trace[1062615313] 'agreement among raft nodes before linearized reading'  (duration: 106.434991ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:36:58.350713Z","caller":"traceutil/trace.go:171","msg":"trace[204981911] transaction","detail":"{read_only:false; response_revision:25183; number_of_response:1; }","duration":"148.192132ms","start":"2026-10-04T06:36:58.202495Z","end":"2026-10-04T06:36:58.350687Z","steps":["trace[204981911] 'process raft request'  (duration: 146.54846ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:36:58.624583Z","caller":"traceutil/trace.go:171","msg":"trace[1933729300] linearizableReadLoop","detail":"{readStateIndex:26002; appliedIndex:26001; }","duration":"198.238327ms","start":"2026-10-04T06:36:58.426316Z","end":"2026-10-04T06:36:58.624555Z","steps":["trace[1933729300] 'read index received'  (duration: 154.969277ms)","trace[1933729300] 'applied index is now lower than readState.Index'  (duration: 43.26789ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:36:58.624909Z","caller":"traceutil/trace.go:171","msg":"trace[1946514681] transaction","detail":"{read_only:false; response_revision:25184; number_of_response:1; }","duration":"269.622107ms","start":"2026-10-04T06:36:58.355268Z","end":"2026-10-04T06:36:58.62489Z","steps":["trace[1946514681] 'process raft request'  (duration: 226.004249ms)","trace[1946514681] 'compare'  (duration: 43.064924ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:36:58.625521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.122559ms","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-04T06:36:58.625948Z","caller":"traceutil/trace.go:171","msg":"trace[258792762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25184; }","duration":"199.722624ms","start":"2026-10-04T06:36:58.426207Z","end":"2026-10-04T06:36:58.62593Z","steps":["trace[258792762] 'agreement among raft nodes before linearized reading'  (duration: 199.005976ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:36:58.626572Z","caller":"traceutil/trace.go:171","msg":"trace[298941683] transaction","detail":"{read_only:false; response_revision:25185; number_of_response:1; }","duration":"147.408872ms","start":"2026-10-04T06:36:58.479145Z","end":"2026-10-04T06:36:58.626554Z","steps":["trace[298941683] 'process raft request'  (duration: 146.764475ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:36:58.627051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.298394ms","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-04T06:36:58.627164Z","caller":"traceutil/trace.go:171","msg":"trace[1652845118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25186; }","duration":"200.222328ms","start":"2026-10-04T06:36:58.426918Z","end":"2026-10-04T06:36:58.62714Z","steps":["trace[1652845118] 'agreement among raft nodes before linearized reading'  (duration: 199.167361ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:03.426704Z","caller":"traceutil/trace.go:171","msg":"trace[913539099] transaction","detail":"{read_only:false; response_revision:25222; number_of_response:1; }","duration":"263.49058ms","start":"2026-10-04T06:37:03.163189Z","end":"2026-10-04T06:37:03.426679Z","steps":["trace[913539099] 'process raft request'  (duration: 263.346606ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:03.45895Z","caller":"traceutil/trace.go:171","msg":"trace[678663071] transaction","detail":"{read_only:false; response_revision:25223; number_of_response:1; }","duration":"203.823289ms","start":"2026-10-04T06:37:03.255081Z","end":"2026-10-04T06:37:03.458904Z","steps":["trace[678663071] 'process raft request'  (duration: 203.528092ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:03.459176Z","caller":"traceutil/trace.go:171","msg":"trace[1029545389] transaction","detail":"{read_only:false; response_revision:25224; number_of_response:1; }","duration":"197.99106ms","start":"2026-10-04T06:37:03.261173Z","end":"2026-10-04T06:37:03.459164Z","steps":["trace[1029545389] 'process raft request'  (duration: 197.650371ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.591202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.509094ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560330867 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25195 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:37:04.591301Z","caller":"traceutil/trace.go:171","msg":"trace[1856172326] linearizableReadLoop","detail":"{readStateIndex:26045; appliedIndex:26044; }","duration":"236.314493ms","start":"2026-10-04T06:37:04.354972Z","end":"2026-10-04T06:37:04.591286Z","steps":["trace[1856172326] 'read index received'  (duration: 95.631154ms)","trace[1856172326] 'applied index is now lower than readState.Index'  (duration: 140.682289ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:04.591369Z","caller":"traceutil/trace.go:171","msg":"trace[101486584] transaction","detail":"{read_only:false; response_revision:25226; number_of_response:1; }","duration":"253.418063ms","start":"2026-10-04T06:37:04.33794Z","end":"2026-10-04T06:37:04.591358Z","steps":["trace[101486584] 'process raft request'  (duration: 112.661222ms)","trace[101486584] 'compare'  (duration: 140.406902ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:04.591635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.625421ms","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-04T06:37:04.591679Z","caller":"traceutil/trace.go:171","msg":"trace[983193905] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25226; }","duration":"236.720833ms","start":"2026-10-04T06:37:04.354945Z","end":"2026-10-04T06:37:04.591666Z","steps":["trace[983193905] 'agreement among raft nodes before linearized reading'  (duration: 236.61329ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:04.767829Z","caller":"traceutil/trace.go:171","msg":"trace[423981841] transaction","detail":"{read_only:false; response_revision:25227; number_of_response:1; }","duration":"380.099953ms","start":"2026-10-04T06:37:04.387683Z","end":"2026-10-04T06:37:04.767783Z","steps":["trace[423981841] 'process raft request'  (duration: 379.954679ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.387662Z","time spent":"380.238267ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25211 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-04T06:37:04.768292Z","caller":"traceutil/trace.go:171","msg":"trace[1359273803] linearizableReadLoop","detail":"{readStateIndex:26046; appliedIndex:26045; }","duration":"176.9363ms","start":"2026-10-04T06:37:04.591323Z","end":"2026-10-04T06:37:04.76826Z","steps":["trace[1359273803] 'read index received'  (duration: 176.260903ms)","trace[1359273803] 'applied index is now lower than readState.Index'  (duration: 672.747µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:04.76848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.690985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:04.768523Z","caller":"traceutil/trace.go:171","msg":"trace[2134481058] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:25227; }","duration":"339.786118ms","start":"2026-10-04T06:37:04.428722Z","end":"2026-10-04T06:37:04.768508Z","steps":["trace[2134481058] 'agreement among raft nodes before linearized reading'  (duration: 339.670185ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.768567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.428701Z","time spent":"339.854239ms","remote":"127.0.0.1:56706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true "}
{"level":"info","ts":"2026-10-04T06:37:04.987717Z","caller":"traceutil/trace.go:171","msg":"trace[1294548667] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"339.583152ms","start":"2026-10-04T06:37:04.648074Z","end":"2026-10-04T06:37:04.987657Z","steps":["trace[1294548667] 'process raft request'  (duration: 239.489045ms)","trace[1294548667] 'compare'  (duration: 99.78772ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:04.987772Z","caller":"traceutil/trace.go:171","msg":"trace[209437537] linearizableReadLoop","detail":"{readStateIndex:26048; appliedIndex:26046; }","duration":"219.390939ms","start":"2026-10-04T06:37:04.768363Z","end":"2026-10-04T06:37:04.987754Z","steps":["trace[209437537] 'read index received'  (duration: 119.049295ms)","trace[209437537] 'applied index is now lower than readState.Index'  (duration: 100.340624ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:04.987913Z","caller":"traceutil/trace.go:171","msg":"trace[1770716225] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"338.569846ms","start":"2026-10-04T06:37:04.649336Z","end":"2026-10-04T06:37:04.987906Z","steps":["trace[1770716225] 'process raft request'  (duration: 338.230907ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.987912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.648051Z","time spent":"339.776898ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25214 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:04.987986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.649324Z","time spent":"338.605686ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25215 > 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-04T06:37:04.988106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.214816ms","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-04T06:37:04.988122Z","caller":"traceutil/trace.go:171","msg":"trace[337497369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25229; }","duration":"334.267137ms","start":"2026-10-04T06:37:04.653849Z","end":"2026-10-04T06:37:04.988116Z","steps":["trace[337497369] 'agreement among raft nodes before linearized reading'  (duration: 334.200345ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.988136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.653829Z","time spent":"334.302828ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-10-04T06:37:04.988125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.881589ms","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-04T06:37:04.98817Z","caller":"traceutil/trace.go:171","msg":"trace[1789405417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25229; }","duration":"328.966181ms","start":"2026-10-04T06:37:04.659192Z","end":"2026-10-04T06:37:04.988158Z","steps":["trace[1789405417] 'agreement among raft nodes before linearized reading'  (duration: 328.840478ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.988195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.932031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T06:37:04.988198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.659173Z","time spent":"329.018062ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-10-04T06:37:04.988207Z","caller":"traceutil/trace.go:171","msg":"trace[731186091] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25229; }","duration":"125.982872ms","start":"2026-10-04T06:37:04.862219Z","end":"2026-10-04T06:37:04.988202Z","steps":["trace[731186091] 'agreement among raft nodes before linearized reading'  (duration: 125.947141ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.988213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.456321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-10-04T06:37:04.988254Z","caller":"traceutil/trace.go:171","msg":"trace[251201541] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25229; }","duration":"136.533653ms","start":"2026-10-04T06:37:04.851709Z","end":"2026-10-04T06:37:04.988243Z","steps":["trace[251201541] 'agreement among raft nodes before linearized reading'  (duration: 136.381679ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.988299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.460839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"warn","ts":"2026-10-04T06:37:04.988341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.765034ms","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-04T06:37:04.988368Z","caller":"traceutil/trace.go:171","msg":"trace[82959227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25229; }","duration":"326.820175ms","start":"2026-10-04T06:37:04.66154Z","end":"2026-10-04T06:37:04.98836Z","steps":["trace[82959227] 'agreement among raft nodes before linearized reading'  (duration: 326.722403ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:04.98838Z","caller":"traceutil/trace.go:171","msg":"trace[822969999] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:25229; }","duration":"255.157386ms","start":"2026-10-04T06:37:04.7332Z","end":"2026-10-04T06:37:04.988358Z","steps":["trace[822969999] 'agreement among raft nodes before linearized reading'  (duration: 254.888689ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:04.98839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:04.661528Z","time spent":"326.856367ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-10-04T06:37:05.290898Z","caller":"traceutil/trace.go:171","msg":"trace[214228763] linearizableReadLoop","detail":"{readStateIndex:26054; appliedIndex:26053; }","duration":"128.084897ms","start":"2026-10-04T06:37:05.16279Z","end":"2026-10-04T06:37:05.290875Z","steps":["trace[214228763] 'read index received'  (duration: 122.919014ms)","trace[214228763] 'applied index is now lower than readState.Index'  (duration: 5.164643ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:05.291022Z","caller":"traceutil/trace.go:171","msg":"trace[1169143679] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"139.878689ms","start":"2026-10-04T06:37:05.151131Z","end":"2026-10-04T06:37:05.29101Z","steps":["trace[1169143679] 'process raft request'  (duration: 134.615134ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:05.291222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.422565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:05.291265Z","caller":"traceutil/trace.go:171","msg":"trace[1620694677] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:25235; }","duration":"128.514607ms","start":"2026-10-04T06:37:05.162738Z","end":"2026-10-04T06:37:05.291252Z","steps":["trace[1620694677] 'agreement among raft nodes before linearized reading'  (duration: 128.431275ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:05.579549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.267707ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560330885 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:25222 > 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-04T06:37:05.579672Z","caller":"traceutil/trace.go:171","msg":"trace[409241679] transaction","detail":"{read_only:false; response_revision:25237; number_of_response:1; }","duration":"148.226293ms","start":"2026-10-04T06:37:05.431425Z","end":"2026-10-04T06:37:05.579651Z","steps":["trace[409241679] 'process raft request'  (duration: 11.777682ms)","trace[409241679] 'compare'  (duration: 136.045811ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:05.874242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.716004ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560330886 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25224 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:37:05.874322Z","caller":"traceutil/trace.go:171","msg":"trace[2077268777] transaction","detail":"{read_only:false; response_revision:25238; number_of_response:1; }","duration":"409.923747ms","start":"2026-10-04T06:37:05.464384Z","end":"2026-10-04T06:37:05.874307Z","steps":["trace[2077268777] 'process raft request'  (duration: 300.075899ms)","trace[2077268777] 'compare'  (duration: 109.513409ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:05.874361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:05.464357Z","time spent":"409.984339ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25224 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-10-04T06:37:05.888193Z","caller":"traceutil/trace.go:171","msg":"trace[104389215] transaction","detail":"{read_only:false; response_revision:25239; number_of_response:1; }","duration":"423.746312ms","start":"2026-10-04T06:37:05.464422Z","end":"2026-10-04T06:37:05.888168Z","steps":["trace[104389215] 'process raft request'  (duration: 423.28433ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:05.888386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:05.464393Z","time spent":"423.921086ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25223 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-04T06:37:06.470538Z","caller":"traceutil/trace.go:171","msg":"trace[26436350] linearizableReadLoop","detail":"{readStateIndex:26059; appliedIndex:26058; }","duration":"139.190161ms","start":"2026-10-04T06:37:06.331331Z","end":"2026-10-04T06:37:06.470521Z","steps":["trace[26436350] 'read index received'  (duration: 139.067698ms)","trace[26436350] 'applied index is now lower than readState.Index'  (duration: 121.913µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:06.470633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.286804ms","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-04T06:37:06.470655Z","caller":"traceutil/trace.go:171","msg":"trace[562623429] 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:25240; }","duration":"139.355246ms","start":"2026-10-04T06:37:06.331291Z","end":"2026-10-04T06:37:06.470646Z","steps":["trace[562623429] 'agreement among raft nodes before linearized reading'  (duration: 139.289244ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:06.470784Z","caller":"traceutil/trace.go:171","msg":"trace[1225775049] transaction","detail":"{read_only:false; response_revision:25240; number_of_response:1; }","duration":"179.488106ms","start":"2026-10-04T06:37:06.291283Z","end":"2026-10-04T06:37:06.470771Z","steps":["trace[1225775049] 'process raft request'  (duration: 179.135017ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:06.898168Z","caller":"traceutil/trace.go:171","msg":"trace[2115812823] transaction","detail":"{read_only:false; response_revision:25241; number_of_response:1; }","duration":"124.392751ms","start":"2026-10-04T06:37:06.773751Z","end":"2026-10-04T06:37:06.898144Z","steps":["trace[2115812823] 'process raft request'  (duration: 124.257618ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.068051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.110108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:07.068151Z","caller":"traceutil/trace.go:171","msg":"trace[1794526076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25241; }","duration":"114.255752ms","start":"2026-10-04T06:37:06.953871Z","end":"2026-10-04T06:37:07.068126Z","steps":["trace[1794526076] 'range keys from in-memory index tree'  (duration: 114.001706ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.068136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.743868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.84\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-10-04T06:37:07.06824Z","caller":"traceutil/trace.go:171","msg":"trace[1311579628] range","detail":"{range_begin:/registry/masterleases/162.253.55.84; range_end:; response_count:1; response_revision:25241; }","duration":"106.900632ms","start":"2026-10-04T06:37:06.961313Z","end":"2026-10-04T06:37:07.068214Z","steps":["trace[1311579628] 'range keys from in-memory index tree'  (duration: 106.559534ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:07.289957Z","caller":"traceutil/trace.go:171","msg":"trace[938503619] linearizableReadLoop","detail":"{readStateIndex:26062; appliedIndex:26060; }","duration":"291.879919ms","start":"2026-10-04T06:37:06.998052Z","end":"2026-10-04T06:37:07.289932Z","steps":["trace[938503619] 'read index received'  (duration: 70.080838ms)","trace[938503619] 'applied index is now lower than readState.Index'  (duration: 221.798221ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:07.290209Z","caller":"traceutil/trace.go:171","msg":"trace[138154531] transaction","detail":"{read_only:false; response_revision:25243; number_of_response:1; }","duration":"296.277931ms","start":"2026-10-04T06:37:06.993919Z","end":"2026-10-04T06:37:07.290197Z","steps":["trace[138154531] 'process raft request'  (duration: 295.781539ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.290467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.397732ms","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-04T06:37:07.290506Z","caller":"traceutil/trace.go:171","msg":"trace[446454295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25243; }","duration":"292.473624ms","start":"2026-10-04T06:37:06.998024Z","end":"2026-10-04T06:37:07.290497Z","steps":["trace[446454295] 'agreement among raft nodes before linearized reading'  (duration: 292.342901ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.29086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.554525ms","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":"warn","ts":"2026-10-04T06:37:07.290898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.214062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T06:37:07.29089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.767722ms","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-04T06:37:07.290934Z","caller":"traceutil/trace.go:171","msg":"trace[1275571980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25243; }","duration":"131.679548ms","start":"2026-10-04T06:37:07.159233Z","end":"2026-10-04T06:37:07.290913Z","steps":["trace[1275571980] 'agreement among raft nodes before linearized reading'  (duration: 131.500144ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:07.290948Z","caller":"traceutil/trace.go:171","msg":"trace[395864676] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25243; }","duration":"291.278373ms","start":"2026-10-04T06:37:06.999653Z","end":"2026-10-04T06:37:07.290932Z","steps":["trace[395864676] 'agreement among raft nodes before linearized reading'  (duration: 291.122369ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.290931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.919038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:07.290959Z","caller":"traceutil/trace.go:171","msg":"trace[1837099561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25243; }","duration":"292.863344ms","start":"2026-10-04T06:37:06.998078Z","end":"2026-10-04T06:37:07.290942Z","steps":["trace[1837099561] 'agreement among raft nodes before linearized reading'  (duration: 292.632557ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.290955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.196887ms","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-04T06:37:07.291005Z","caller":"traceutil/trace.go:171","msg":"trace[2037053970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25243; }","duration":"221.097572ms","start":"2026-10-04T06:37:07.069886Z","end":"2026-10-04T06:37:07.290984Z","steps":["trace[2037053970] 'agreement among raft nodes before linearized reading'  (duration: 220.839326ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:07.291014Z","caller":"traceutil/trace.go:171","msg":"trace[1332901928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25243; }","duration":"292.307901ms","start":"2026-10-04T06:37:06.998688Z","end":"2026-10-04T06:37:07.290996Z","steps":["trace[1332901928] 'agreement among raft nodes before linearized reading'  (duration: 292.091685ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:07.613028Z","caller":"traceutil/trace.go:171","msg":"trace[1096623580] transaction","detail":"{read_only:false; response_revision:25250; number_of_response:1; }","duration":"224.84036ms","start":"2026-10-04T06:37:07.388165Z","end":"2026-10-04T06:37:07.613006Z","steps":["trace[1096623580] 'process raft request'  (duration: 224.698645ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:07.614209Z","caller":"traceutil/trace.go:171","msg":"trace[1772273005] transaction","detail":"{read_only:false; response_revision:25251; number_of_response:1; }","duration":"111.06927ms","start":"2026-10-04T06:37:07.503124Z","end":"2026-10-04T06:37:07.614193Z","steps":["trace[1772273005] 'process raft request'  (duration: 110.643759ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:07.94689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.65483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:180"}
{"level":"info","ts":"2026-10-04T06:37:07.947039Z","caller":"traceutil/trace.go:171","msg":"trace[957802314] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:25252; }","duration":"133.802113ms","start":"2026-10-04T06:37:07.813162Z","end":"2026-10-04T06:37:07.946965Z","steps":["trace[957802314] 'range keys from in-memory index tree'  (duration: 133.488885ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:08.241377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.273544ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560330928 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25239 > 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-04T06:37:08.24148Z","caller":"traceutil/trace.go:171","msg":"trace[1112435945] linearizableReadLoop","detail":"{readStateIndex:26074; appliedIndex:26073; }","duration":"292.143115ms","start":"2026-10-04T06:37:07.949321Z","end":"2026-10-04T06:37:08.241464Z","steps":["trace[1112435945] 'read index received'  (duration: 173.584413ms)","trace[1112435945] 'applied index is now lower than readState.Index'  (duration: 118.557432ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:08.241548Z","caller":"traceutil/trace.go:171","msg":"trace[455546501] transaction","detail":"{read_only:false; response_revision:25254; number_of_response:1; }","duration":"347.927777ms","start":"2026-10-04T06:37:07.89357Z","end":"2026-10-04T06:37:08.241498Z","steps":["trace[455546501] 'process raft request'  (duration: 229.456627ms)","trace[455546501] 'compare'  (duration: 117.726981ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:08.241634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.458145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:08.241652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.34312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-9x4m7\" ","response":"range_response_count:1 size:4905"}
{"level":"info","ts":"2026-10-04T06:37:08.241692Z","caller":"traceutil/trace.go:171","msg":"trace[195691328] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-9x4m7; range_end:; response_count:1; response_revision:25254; }","duration":"292.383971ms","start":"2026-10-04T06:37:07.949299Z","end":"2026-10-04T06:37:08.241683Z","steps":["trace[195691328] 'agreement among raft nodes before linearized reading'  (duration: 292.248338ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:08.241694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:07.89354Z","time spent":"348.081021ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25239 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-04T06:37:08.241693Z","caller":"traceutil/trace.go:171","msg":"trace[2081789878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25254; }","duration":"287.553398ms","start":"2026-10-04T06:37:07.954127Z","end":"2026-10-04T06:37:08.24168Z","steps":["trace[2081789878] 'agreement among raft nodes before linearized reading'  (duration: 287.440535ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.01011Z","caller":"traceutil/trace.go:171","msg":"trace[1207282819] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"107.144919ms","start":"2026-10-04T06:37:08.902935Z","end":"2026-10-04T06:37:09.01008Z","steps":["trace[1207282819] 'process raft request'  (duration: 106.920103ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.531008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.245358ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560330936 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25243 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:37:09.531167Z","caller":"traceutil/trace.go:171","msg":"trace[1466575091] transaction","detail":"{read_only:false; response_revision:25259; number_of_response:1; }","duration":"142.695521ms","start":"2026-10-04T06:37:09.388455Z","end":"2026-10-04T06:37:09.531151Z","steps":["trace[1466575091] 'process raft request'  (duration: 142.64092ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.53966Z","caller":"traceutil/trace.go:171","msg":"trace[542757833] transaction","detail":"{read_only:false; response_revision:25258; number_of_response:1; }","duration":"243.783315ms","start":"2026-10-04T06:37:09.295841Z","end":"2026-10-04T06:37:09.539625Z","steps":["trace[542757833] 'process raft request'  (duration: 101.846784ms)","trace[542757833] 'compare'  (duration: 132.905149ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:09.539737Z","caller":"traceutil/trace.go:171","msg":"trace[1333328009] linearizableReadLoop","detail":"{readStateIndex:26078; appliedIndex:26077; }","duration":"234.149347ms","start":"2026-10-04T06:37:09.305517Z","end":"2026-10-04T06:37:09.539666Z","steps":["trace[1333328009] 'read index received'  (duration: 92.181285ms)","trace[1333328009] 'applied index is now lower than readState.Index'  (duration: 141.963152ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:09.539952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.421053ms","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-04T06:37:09.539998Z","caller":"traceutil/trace.go:171","msg":"trace[1826887322] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25259; }","duration":"234.521867ms","start":"2026-10-04T06:37:09.305466Z","end":"2026-10-04T06:37:09.539988Z","steps":["trace[1826887322] 'agreement among raft nodes before linearized reading'  (duration: 234.379183ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.540086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.820435ms","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-04T06:37:09.540162Z","caller":"traceutil/trace.go:171","msg":"trace[1359925759] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25259; }","duration":"151.906937ms","start":"2026-10-04T06:37:09.388219Z","end":"2026-10-04T06:37:09.540126Z","steps":["trace[1359925759] 'agreement among raft nodes before linearized reading'  (duration: 151.738953ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.54031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.995311ms","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-04T06:37:09.54034Z","caller":"traceutil/trace.go:171","msg":"trace[26123332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25259; }","duration":"152.037572ms","start":"2026-10-04T06:37:09.388294Z","end":"2026-10-04T06:37:09.540332Z","steps":["trace[26123332] 'agreement among raft nodes before linearized reading'  (duration: 151.96761ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.540346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.211124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T06:37:09.540435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.148804ms","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-04T06:37:09.540436Z","caller":"traceutil/trace.go:171","msg":"trace[1325424886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25259; }","duration":"150.305427ms","start":"2026-10-04T06:37:09.390091Z","end":"2026-10-04T06:37:09.540397Z","steps":["trace[1325424886] 'agreement among raft nodes before linearized reading'  (duration: 150.131422ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.540457Z","caller":"traceutil/trace.go:171","msg":"trace[795514737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25259; }","duration":"152.202445ms","start":"2026-10-04T06:37:09.388243Z","end":"2026-10-04T06:37:09.540445Z","steps":["trace[795514737] 'agreement among raft nodes before linearized reading'  (duration: 152.151004ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.884096Z","caller":"traceutil/trace.go:171","msg":"trace[657783902] transaction","detail":"{read_only:false; response_revision:25260; number_of_response:1; }","duration":"328.759425ms","start":"2026-10-04T06:37:09.555306Z","end":"2026-10-04T06:37:09.884066Z","steps":["trace[657783902] 'process raft request'  (duration: 328.55815ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.884268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.555283Z","time spent":"328.899908ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25246 > 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-04T06:37:09.924041Z","caller":"traceutil/trace.go:171","msg":"trace[373138313] transaction","detail":"{read_only:false; response_revision:25261; number_of_response:1; }","duration":"368.608757ms","start":"2026-10-04T06:37:09.555405Z","end":"2026-10-04T06:37:09.924013Z","steps":["trace[373138313] 'process raft request'  (duration: 368.377101ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.924197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.555392Z","time spent":"368.71621ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25245 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-04T06:37:09.924331Z","caller":"traceutil/trace.go:171","msg":"trace[1901101394] transaction","detail":"{read_only:false; response_revision:25262; number_of_response:1; }","duration":"368.898075ms","start":"2026-10-04T06:37:09.555405Z","end":"2026-10-04T06:37:09.924303Z","steps":["trace[1901101394] 'process raft request'  (duration: 368.562286ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.924395Z","caller":"traceutil/trace.go:171","msg":"trace[1302957359] transaction","detail":"{read_only:false; response_revision:25264; number_of_response:1; }","duration":"327.666887ms","start":"2026-10-04T06:37:09.596713Z","end":"2026-10-04T06:37:09.92438Z","steps":["trace[1302957359] 'process raft request'  (duration: 327.589305ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.924436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.555391Z","time spent":"368.990607ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25247 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:09.924484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.596677Z","time spent":"327.76394ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25226 > 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":"info","ts":"2026-10-04T06:37:09.924485Z","caller":"traceutil/trace.go:171","msg":"trace[230174425] transaction","detail":"{read_only:false; response_revision:25263; number_of_response:1; }","duration":"368.970667ms","start":"2026-10-04T06:37:09.555483Z","end":"2026-10-04T06:37:09.924454Z","steps":["trace[230174425] 'process raft request'  (duration: 368.716691ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.924495Z","caller":"traceutil/trace.go:171","msg":"trace[442362480] linearizableReadLoop","detail":"{readStateIndex:26084; appliedIndex:26079; }","duration":"309.213284ms","start":"2026-10-04T06:37:09.615251Z","end":"2026-10-04T06:37:09.924464Z","steps":["trace[442362480] 'read index received'  (duration: 268.617092ms)","trace[442362480] 'applied index is now lower than readState.Index'  (duration: 40.594872ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:09.924537Z","caller":"traceutil/trace.go:171","msg":"trace[891528687] transaction","detail":"{read_only:false; response_revision:25265; number_of_response:1; }","duration":"306.147456ms","start":"2026-10-04T06:37:09.618378Z","end":"2026-10-04T06:37:09.924526Z","steps":["trace[891528687] 'process raft request'  (duration: 305.965691ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.9246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.618362Z","time spent":"306.206587ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25252 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:09.924598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.555462Z","time spent":"369.07579ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25248 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:09.924728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.4557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:09.924772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.180857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T06:37:09.924779Z","caller":"traceutil/trace.go:171","msg":"trace[208803060] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25265; }","duration":"309.551063ms","start":"2026-10-04T06:37:09.615208Z","end":"2026-10-04T06:37:09.924759Z","steps":["trace[208803060] 'agreement among raft nodes before linearized reading'  (duration: 309.412239ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:09.924829Z","caller":"traceutil/trace.go:171","msg":"trace[615260295] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25265; }","duration":"308.238599ms","start":"2026-10-04T06:37:09.61656Z","end":"2026-10-04T06:37:09.924798Z","steps":["trace[615260295] 'agreement among raft nodes before linearized reading'  (duration: 308.113495ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:09.924844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.615191Z","time spent":"309.642375ms","remote":"127.0.0.1:48114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-10-04T06:37:09.924858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:09.616551Z","time spent":"308.29982ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-04T06:37:09.924899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.926955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"}
{"level":"info","ts":"2026-10-04T06:37:09.924959Z","caller":"traceutil/trace.go:171","msg":"trace[656705191] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:25265; }","duration":"141.020198ms","start":"2026-10-04T06:37:09.78392Z","end":"2026-10-04T06:37:09.924941Z","steps":["trace[656705191] 'agreement among raft nodes before linearized reading'  (duration: 140.824203ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.612017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.650572ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560331014 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:25277 > 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-04T06:37:14.612222Z","caller":"traceutil/trace.go:171","msg":"trace[1606959700] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"640.729039ms","start":"2026-10-04T06:37:13.971476Z","end":"2026-10-04T06:37:14.612205Z","steps":["trace[1606959700] 'process raft request'  (duration: 640.644747ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.612295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:13.971456Z","time spent":"640.803912ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25282 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-10-04T06:37:14.612269Z","caller":"traceutil/trace.go:171","msg":"trace[313214881] transaction","detail":"{read_only:false; response_revision:25290; number_of_response:1; }","duration":"677.39173ms","start":"2026-10-04T06:37:13.934834Z","end":"2026-10-04T06:37:14.612225Z","steps":["trace[313214881] 'process raft request'  (duration: 272.45199ms)","trace[313214881] 'compare'  (duration: 404.284733ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:14.612459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:13.934795Z","time spent":"677.561054ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25277 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-04T06:37:14.612461Z","caller":"traceutil/trace.go:171","msg":"trace[291836969] linearizableReadLoop","detail":"{readStateIndex:26111; appliedIndex:26110; }","duration":"674.753932ms","start":"2026-10-04T06:37:13.937674Z","end":"2026-10-04T06:37:14.612428Z","steps":["trace[291836969] 'read index received'  (duration: 269.726051ms)","trace[291836969] 'applied index is now lower than readState.Index'  (duration: 405.024221ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:14.612706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.02155ms","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-04T06:37:14.612744Z","caller":"traceutil/trace.go:171","msg":"trace[72892943] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25291; }","duration":"675.100431ms","start":"2026-10-04T06:37:13.937635Z","end":"2026-10-04T06:37:14.612736Z","steps":["trace[72892943] 'agreement among raft nodes before linearized reading'  (duration: 674.939437ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.612772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:13.937602Z","time spent":"675.162203ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-10-04T06:37:14.64926Z","caller":"traceutil/trace.go:171","msg":"trace[1477499424] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"383.874349ms","start":"2026-10-04T06:37:14.265356Z","end":"2026-10-04T06:37:14.64923Z","steps":["trace[1477499424] 'process raft request'  (duration: 383.680745ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.649365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.690505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:14.649428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.26533Z","time spent":"384.006272ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25283 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:14.649449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.149459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:14.649467Z","caller":"traceutil/trace.go:171","msg":"trace[423292814] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:25292; }","duration":"620.842009ms","start":"2026-10-04T06:37:14.028601Z","end":"2026-10-04T06:37:14.649443Z","steps":["trace[423292814] 'agreement among raft nodes before linearized reading'  (duration: 620.651454ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.649494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.737736ms","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-04T06:37:14.649522Z","caller":"traceutil/trace.go:171","msg":"trace[597134434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25292; }","duration":"222.332454ms","start":"2026-10-04T06:37:14.427172Z","end":"2026-10-04T06:37:14.649504Z","steps":["trace[597134434] 'agreement among raft nodes before linearized reading'  (duration: 222.209501ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.649533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.028583Z","time spent":"620.934341ms","remote":"127.0.0.1:46538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true "}
{"level":"info","ts":"2026-10-04T06:37:14.649556Z","caller":"traceutil/trace.go:171","msg":"trace[1306948337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25292; }","duration":"102.984151ms","start":"2026-10-04T06:37:14.546554Z","end":"2026-10-04T06:37:14.649538Z","steps":["trace[1306948337] 'agreement among raft nodes before linearized reading'  (duration: 102.760026ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.649582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.254398ms","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-04T06:37:14.649651Z","caller":"traceutil/trace.go:171","msg":"trace[1015638009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25292; }","duration":"709.34528ms","start":"2026-10-04T06:37:13.940289Z","end":"2026-10-04T06:37:14.649635Z","steps":["trace[1015638009] 'agreement among raft nodes before linearized reading'  (duration: 709.132854ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.649697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:13.940281Z","time spent":"709.403671ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-10-04T06:37:14.649764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.801247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T06:37:14.649903Z","caller":"traceutil/trace.go:171","msg":"trace[304309516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25292; }","duration":"710.866559ms","start":"2026-10-04T06:37:13.93893Z","end":"2026-10-04T06:37:14.649797Z","steps":["trace[304309516] 'agreement among raft nodes before linearized reading'  (duration: 710.701345ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.649952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:13.93892Z","time spent":"711.020802ms","remote":"127.0.0.1:47922","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-04T06:37:14.65035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.40868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T06:37:14.650428Z","caller":"traceutil/trace.go:171","msg":"trace[1911610734] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25292; }","duration":"698.507822ms","start":"2026-10-04T06:37:13.951897Z","end":"2026-10-04T06:37:14.650405Z","steps":["trace[1911610734] 'agreement among raft nodes before linearized reading'  (duration: 697.65752ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:14.650472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:13.951882Z","time spent":"698.577995ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-04T06:37:15.103094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.960133ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560331018 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25278 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:37:15.103292Z","caller":"traceutil/trace.go:171","msg":"trace[1414709557] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"486.384708ms","start":"2026-10-04T06:37:14.616874Z","end":"2026-10-04T06:37:15.103259Z","steps":["trace[1414709557] 'process raft request'  (duration: 266.169499ms)","trace[1414709557] 'compare'  (duration: 219.567393ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:15.103363Z","caller":"traceutil/trace.go:171","msg":"trace[2002098358] linearizableReadLoop","detail":"{readStateIndex:26114; appliedIndex:26113; }","duration":"454.137142ms","start":"2026-10-04T06:37:14.649191Z","end":"2026-10-04T06:37:15.103328Z","steps":["trace[2002098358] 'read index received'  (duration: 233.865821ms)","trace[2002098358] 'applied index is now lower than readState.Index'  (duration: 220.267581ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:15.10341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.616847Z","time spent":"486.507662ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25278 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-04T06:37:15.103432Z","caller":"traceutil/trace.go:171","msg":"trace[617259386] transaction","detail":"{read_only:false; response_revision:25297; number_of_response:1; }","duration":"447.739157ms","start":"2026-10-04T06:37:14.65568Z","end":"2026-10-04T06:37:15.103419Z","steps":["trace[617259386] 'process raft request'  (duration: 447.695966ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.103494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.655666Z","time spent":"447.795129ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25281 > 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-04T06:37:15.103585Z","caller":"traceutil/trace.go:171","msg":"trace[1464870874] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"448.21409ms","start":"2026-10-04T06:37:14.655362Z","end":"2026-10-04T06:37:15.103576Z","steps":["trace[1464870874] 'process raft request'  (duration: 447.983365ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:15.103585Z","caller":"traceutil/trace.go:171","msg":"trace[505359751] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"449.355069ms","start":"2026-10-04T06:37:14.654204Z","end":"2026-10-04T06:37:15.103559Z","steps":["trace[505359751] 'process raft request'  (duration: 448.99494ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.103684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.655349Z","time spent":"448.309583ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25280 > 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-04T06:37:15.103723Z","caller":"traceutil/trace.go:171","msg":"trace[1751453369] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"448.470376ms","start":"2026-10-04T06:37:14.655097Z","end":"2026-10-04T06:37:15.103567Z","steps":["trace[1751453369] 'process raft request'  (duration: 448.20538ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.103789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.65417Z","time spent":"449.519213ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25284 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:15.10389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.655069Z","time spent":"448.722624ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25279 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:15.103964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.94926ms","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-04T06:37:15.104034Z","caller":"traceutil/trace.go:171","msg":"trace[508944822] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25297; }","duration":"472.056522ms","start":"2026-10-04T06:37:14.631959Z","end":"2026-10-04T06:37:15.104016Z","steps":["trace[508944822] 'agreement among raft nodes before linearized reading'  (duration: 471.516707ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.104085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.631943Z","time spent":"472.125084ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":381,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"info","ts":"2026-10-04T06:37:15.47186Z","caller":"traceutil/trace.go:171","msg":"trace[1081780810] transaction","detail":"{read_only:false; response_revision:25298; number_of_response:1; }","duration":"541.066872ms","start":"2026-10-04T06:37:14.930724Z","end":"2026-10-04T06:37:15.471791Z","steps":["trace[1081780810] 'process raft request'  (duration: 518.890793ms)","trace[1081780810] 'compare'  (duration: 20.964218ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:15.472012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.930708Z","time spent":"541.227776ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25264 > 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":"info","ts":"2026-10-04T06:37:15.472112Z","caller":"traceutil/trace.go:171","msg":"trace[1114855442] linearizableReadLoop","detail":"{readStateIndex:26120; appliedIndex:26118; }","duration":"368.645999ms","start":"2026-10-04T06:37:15.103442Z","end":"2026-10-04T06:37:15.472088Z","steps":["trace[1114855442] 'read index received'  (duration: 346.265065ms)","trace[1114855442] 'applied index is now lower than readState.Index'  (duration: 22.380134ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:15.472129Z","caller":"traceutil/trace.go:171","msg":"trace[1648439631] transaction","detail":"{read_only:false; response_revision:25299; number_of_response:1; }","duration":"438.264034ms","start":"2026-10-04T06:37:15.033828Z","end":"2026-10-04T06:37:15.472092Z","steps":["trace[1648439631] 'process raft request'  (duration: 438.021218ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:15.472224Z","caller":"traceutil/trace.go:171","msg":"trace[1613183015] transaction","detail":"{read_only:false; response_revision:25300; number_of_response:1; }","duration":"293.124101ms","start":"2026-10-04T06:37:15.179071Z","end":"2026-10-04T06:37:15.472195Z","steps":["trace[1613183015] 'process raft request'  (duration: 292.980577ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.472289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.235542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-10-04T06:37:15.472283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.738504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:15.47229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:15.033787Z","time spent":"438.416088ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25285 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-04T06:37:15.472322Z","caller":"traceutil/trace.go:171","msg":"trace[1248366938] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:25300; }","duration":"816.311324ms","start":"2026-10-04T06:37:14.656001Z","end":"2026-10-04T06:37:15.472312Z","steps":["trace[1248366938] 'agreement among raft nodes before linearized reading'  (duration: 816.17766ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.472291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.402244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:15.472333Z","caller":"traceutil/trace.go:171","msg":"trace[207731976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25300; }","duration":"517.832687ms","start":"2026-10-04T06:37:14.954487Z","end":"2026-10-04T06:37:15.47232Z","steps":["trace[207731976] 'agreement among raft nodes before linearized reading'  (duration: 517.629152ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.472357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.655985Z","time spent":"816.361905ms","remote":"127.0.0.1:47932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":92,"response size":32,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T06:37:15.472339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.96898ms","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-04T06:37:15.47243Z","caller":"traceutil/trace.go:171","msg":"trace[185723692] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25300; }","duration":"518.064222ms","start":"2026-10-04T06:37:14.954348Z","end":"2026-10-04T06:37:15.472412Z","steps":["trace[185723692] 'agreement among raft nodes before linearized reading'  (duration: 517.754064ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.472499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.954281Z","time spent":"518.188355ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-04T06:37:15.472366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.954474Z","time spent":"517.884948ms","remote":"127.0.0.1:47686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-04T06:37:15.47237Z","caller":"traceutil/trace.go:171","msg":"trace[9014748] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:25300; }","duration":"554.572118ms","start":"2026-10-04T06:37:14.917776Z","end":"2026-10-04T06:37:15.472348Z","steps":["trace[9014748] 'agreement among raft nodes before linearized reading'  (duration: 554.362083ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:15.472675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:14.917756Z","time spent":"554.906167ms","remote":"127.0.0.1:47894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"info","ts":"2026-10-04T06:37:22.760176Z","caller":"traceutil/trace.go:171","msg":"trace[1022238602] transaction","detail":"{read_only:false; response_revision:25414; number_of_response:1; }","duration":"123.088178ms","start":"2026-10-04T06:37:22.637063Z","end":"2026-10-04T06:37:22.760151Z","steps":["trace[1022238602] 'process raft request'  (duration: 122.677087ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:23.366463Z","caller":"traceutil/trace.go:171","msg":"trace[1035032823] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"190.155549ms","start":"2026-10-04T06:37:23.176287Z","end":"2026-10-04T06:37:23.366442Z","steps":["trace[1035032823] 'process raft request'  (duration: 143.021429ms)","trace[1035032823] 'compare'  (duration: 47.050848ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:23.628289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.502923ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560331345 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25344 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:37:23.628496Z","caller":"traceutil/trace.go:171","msg":"trace[1367139422] transaction","detail":"{read_only:false; response_revision:25420; number_of_response:1; }","duration":"448.452016ms","start":"2026-10-04T06:37:23.180027Z","end":"2026-10-04T06:37:23.628479Z","steps":["trace[1367139422] 'process raft request'  (duration: 448.412995ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:23.628573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:23.18002Z","time spent":"448.515019ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25342 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-04T06:37:23.628927Z","caller":"traceutil/trace.go:171","msg":"trace[1868353395] transaction","detail":"{read_only:false; response_revision:25418; number_of_response:1; }","duration":"450.681813ms","start":"2026-10-04T06:37:23.178231Z","end":"2026-10-04T06:37:23.628913Z","steps":["trace[1868353395] 'process raft request'  (duration: 341.485662ms)","trace[1868353395] 'compare'  (duration: 108.39969ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:23.628993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:23.17821Z","time spent":"450.751525ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25344 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-04T06:37:23.629122Z","caller":"traceutil/trace.go:171","msg":"trace[356783689] transaction","detail":"{read_only:false; response_revision:25419; number_of_response:1; }","duration":"450.393136ms","start":"2026-10-04T06:37:23.17872Z","end":"2026-10-04T06:37:23.629113Z","steps":["trace[356783689] 'process raft request'  (duration: 449.671078ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:23.629176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:23.178712Z","time spent":"450.436477ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25343 > 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-04T06:37:23.636668Z","caller":"traceutil/trace.go:171","msg":"trace[631040445] transaction","detail":"{read_only:false; response_revision:25421; number_of_response:1; }","duration":"134.757537ms","start":"2026-10-04T06:37:23.50189Z","end":"2026-10-04T06:37:23.636648Z","steps":["trace[631040445] 'process raft request'  (duration: 134.615254ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:23.636846Z","caller":"traceutil/trace.go:171","msg":"trace[1170460722] transaction","detail":"{read_only:false; response_revision:25422; number_of_response:1; }","duration":"120.737039ms","start":"2026-10-04T06:37:23.5161Z","end":"2026-10-04T06:37:23.636837Z","steps":["trace[1170460722] 'process raft request'  (duration: 120.514792ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:23.799865Z","caller":"traceutil/trace.go:171","msg":"trace[1704629689] transaction","detail":"{read_only:false; response_revision:25423; number_of_response:1; }","duration":"114.790095ms","start":"2026-10-04T06:37:23.685051Z","end":"2026-10-04T06:37:23.799841Z","steps":["trace[1704629689] 'process raft request'  (duration: 102.406107ms)","trace[1704629689] 'compare'  (duration: 12.221624ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:24.059918Z","caller":"traceutil/trace.go:171","msg":"trace[25956303] transaction","detail":"{read_only:false; response_revision:25424; number_of_response:1; }","duration":"363.760483ms","start":"2026-10-04T06:37:23.696119Z","end":"2026-10-04T06:37:24.059879Z","steps":["trace[25956303] 'process raft request'  (duration: 290.460992ms)","trace[25956303] 'compare'  (duration: 72.964321ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:24.060092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:23.696096Z","time spent":"363.902627ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25394 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:24.060097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.26938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-71889a5f-1c2f-4634-8fcf-75c6e4bbcb73\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-10-04T06:37:24.060168Z","caller":"traceutil/trace.go:171","msg":"trace[993381003] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-71889a5f-1c2f-4634-8fcf-75c6e4bbcb73; range_end:; response_count:1; response_revision:25424; }","duration":"294.391833ms","start":"2026-10-04T06:37:23.765759Z","end":"2026-10-04T06:37:24.060151Z","steps":["trace[993381003] 'agreement among raft nodes before linearized reading'  (duration: 294.195938ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:24.059896Z","caller":"traceutil/trace.go:171","msg":"trace[1374640510] linearizableReadLoop","detail":"{readStateIndex:26247; appliedIndex:26245; }","duration":"294.045794ms","start":"2026-10-04T06:37:23.765806Z","end":"2026-10-04T06:37:24.059852Z","steps":["trace[1374640510] 'read index received'  (duration: 21.579473ms)","trace[1374640510] 'applied index is now lower than readState.Index'  (duration: 272.464381ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:24.060547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.867524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"warn","ts":"2026-10-04T06:37:24.060597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.076967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:24.060623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.067987ms","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-04T06:37:24.060804Z","caller":"traceutil/trace.go:171","msg":"trace[313655614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25424; }","duration":"100.249702ms","start":"2026-10-04T06:37:23.960541Z","end":"2026-10-04T06:37:24.060791Z","steps":["trace[313655614] 'agreement among raft nodes before linearized reading'  (duration: 100.000056ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:24.060627Z","caller":"traceutil/trace.go:171","msg":"trace[1900218914] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25424; }","duration":"270.027419ms","start":"2026-10-04T06:37:23.790556Z","end":"2026-10-04T06:37:24.060584Z","steps":["trace[1900218914] 'agreement among raft nodes before linearized reading'  (duration: 269.890735ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:24.060648Z","caller":"traceutil/trace.go:171","msg":"trace[622338948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25424; }","duration":"107.164609ms","start":"2026-10-04T06:37:23.953468Z","end":"2026-10-04T06:37:24.060633Z","steps":["trace[622338948] 'agreement among raft nodes before linearized reading'  (duration: 107.074917ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:26.182775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.563739ms","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-04T06:37:26.18289Z","caller":"traceutil/trace.go:171","msg":"trace[1284598280] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25438; }","duration":"425.735164ms","start":"2026-10-04T06:37:25.757138Z","end":"2026-10-04T06:37:26.182873Z","steps":["trace[1284598280] 'range keys from in-memory index tree'  (duration: 425.319303ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:26.18293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:25.757114Z","time spent":"425.806396ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-04T06:37:26.182985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.729331ms","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-04T06:37:26.183091Z","caller":"traceutil/trace.go:171","msg":"trace[614271408] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:25438; }","duration":"407.933926ms","start":"2026-10-04T06:37:25.775129Z","end":"2026-10-04T06:37:26.183063Z","steps":["trace[614271408] 'count revisions from in-memory index tree'  (duration: 407.632099ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:26.183156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:25.775105Z","time spent":"408.033288ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":22,"response size":32,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-10-04T06:37:26.183372Z","caller":"traceutil/trace.go:171","msg":"trace[1287424513] linearizableReadLoop","detail":"{readStateIndex:26262; appliedIndex:26261; }","duration":"229.13003ms","start":"2026-10-04T06:37:25.954219Z","end":"2026-10-04T06:37:26.183349Z","steps":["trace[1287424513] 'read index received'  (duration: 206.891159ms)","trace[1287424513] 'applied index is now lower than readState.Index'  (duration: 22.237211ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:26.183414Z","caller":"traceutil/trace.go:171","msg":"trace[1751945764] transaction","detail":"{read_only:false; response_revision:25439; number_of_response:1; }","duration":"379.386875ms","start":"2026-10-04T06:37:25.804007Z","end":"2026-10-04T06:37:26.183393Z","steps":["trace[1751945764] 'process raft request'  (duration: 357.088182ms)","trace[1751945764] 'compare'  (duration: 21.689956ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:26.18351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:25.803969Z","time spent":"379.477587ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25423 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:26.183534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.305634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:26.183586Z","caller":"traceutil/trace.go:171","msg":"trace[786540137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25439; }","duration":"229.397796ms","start":"2026-10-04T06:37:25.954174Z","end":"2026-10-04T06:37:26.183572Z","steps":["trace[786540137] 'agreement among raft nodes before linearized reading'  (duration: 229.303894ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:26.187704Z","caller":"traceutil/trace.go:171","msg":"trace[1112266066] transaction","detail":"{read_only:false; response_revision:25440; number_of_response:1; }","duration":"122.325309ms","start":"2026-10-04T06:37:26.065348Z","end":"2026-10-04T06:37:26.187673Z","steps":["trace[1112266066] 'process raft request'  (duration: 122.084803ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:26.187769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.958172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-71889a5f-1c2f-4634-8fcf-75c6e4bbcb73\" ","response":"range_response_count:1 size:3949"}
{"level":"info","ts":"2026-10-04T06:37:26.187882Z","caller":"traceutil/trace.go:171","msg":"trace[1613943697] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-71889a5f-1c2f-4634-8fcf-75c6e4bbcb73; range_end:; response_count:1; response_revision:25440; }","duration":"119.116806ms","start":"2026-10-04T06:37:26.068746Z","end":"2026-10-04T06:37:26.187863Z","steps":["trace[1613943697] 'agreement among raft nodes before linearized reading'  (duration: 118.825038ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:29.442228Z","caller":"traceutil/trace.go:171","msg":"trace[1887163525] transaction","detail":"{read_only:false; response_revision:25478; number_of_response:1; }","duration":"201.808797ms","start":"2026-10-04T06:37:29.240393Z","end":"2026-10-04T06:37:29.442202Z","steps":["trace[1887163525] 'process raft request'  (duration: 201.471169ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.155539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.752279ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560331478 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25456 > 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-04T06:37:30.155726Z","caller":"traceutil/trace.go:171","msg":"trace[1481600943] transaction","detail":"{read_only:false; response_revision:25479; number_of_response:1; }","duration":"704.025334ms","start":"2026-10-04T06:37:29.451675Z","end":"2026-10-04T06:37:30.1557Z","steps":["trace[1481600943] 'process raft request'  (duration: 56.034058ms)","trace[1481600943] 'compare'  (duration: 647.409761ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:30.155847Z","caller":"traceutil/trace.go:171","msg":"trace[1885231386] transaction","detail":"{read_only:false; response_revision:25481; number_of_response:1; }","duration":"458.300609ms","start":"2026-10-04T06:37:29.697506Z","end":"2026-10-04T06:37:30.155806Z","steps":["trace[1885231386] 'process raft request'  (duration: 458.255988ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.155857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.451655Z","time spent":"704.121456ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25456 > 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-04T06:37:30.155916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.697497Z","time spent":"458.385151ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25460 > 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-04T06:37:30.156048Z","caller":"traceutil/trace.go:171","msg":"trace[45692997] linearizableReadLoop","detail":"{readStateIndex:26304; appliedIndex:26303; }","duration":"677.242827ms","start":"2026-10-04T06:37:29.478792Z","end":"2026-10-04T06:37:30.156035Z","steps":["trace[45692997] 'read index received'  (duration: 28.753788ms)","trace[45692997] 'applied index is now lower than readState.Index'  (duration: 648.488039ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:37:30.156184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.50008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:37:30.15622Z","caller":"traceutil/trace.go:171","msg":"trace[1820663831] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:25481; }","duration":"475.572072ms","start":"2026-10-04T06:37:29.680637Z","end":"2026-10-04T06:37:30.156209Z","steps":["trace[1820663831] 'agreement among raft nodes before linearized reading'  (duration: 475.49348ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.680616Z","time spent":"475.623233ms","remote":"127.0.0.1:48166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":32,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T06:37:30.156243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.423431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:30.156341Z","caller":"traceutil/trace.go:171","msg":"trace[1367370378] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:25481; }","duration":"677.552494ms","start":"2026-10-04T06:37:29.478758Z","end":"2026-10-04T06:37:30.156311Z","steps":["trace[1367370378] 'agreement among raft nodes before linearized reading'  (duration: 677.365379ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:30.156373Z","caller":"traceutil/trace.go:171","msg":"trace[357157850] transaction","detail":"{read_only:false; response_revision:25480; number_of_response:1; }","duration":"459.043778ms","start":"2026-10-04T06:37:29.697317Z","end":"2026-10-04T06:37:30.156361Z","steps":["trace[357157850] 'process raft request'  (duration: 458.354601ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.15636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.167502ms","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":"warn","ts":"2026-10-04T06:37:30.156392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.478748Z","time spent":"677.630646ms","remote":"127.0.0.1:46460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T06:37:30.156427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.697303Z","time spent":"459.092779ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25459 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-04T06:37:30.156428Z","caller":"traceutil/trace.go:171","msg":"trace[211026191] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25481; }","duration":"408.276855ms","start":"2026-10-04T06:37:29.748131Z","end":"2026-10-04T06:37:30.156408Z","steps":["trace[211026191] 'agreement among raft nodes before linearized reading'  (duration: 408.094791ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.874629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T06:37:30.156485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.36628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-10-04T06:37:30.156478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.029518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:30.156496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.72848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10358"}
{"level":"warn","ts":"2026-10-04T06:37:30.156482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.748111Z","time spent":"408.350998ms","remote":"127.0.0.1:48194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":60,"response size":32,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"info","ts":"2026-10-04T06:37:30.156544Z","caller":"traceutil/trace.go:171","msg":"trace[1826591544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25481; }","duration":"449.462962ms","start":"2026-10-04T06:37:29.707062Z","end":"2026-10-04T06:37:30.156524Z","steps":["trace[1826591544] 'agreement among raft nodes before linearized reading'  (duration: 449.258767ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.138977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:37:30.156552Z","caller":"traceutil/trace.go:171","msg":"trace[866474134] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:25481; }","duration":"468.130791ms","start":"2026-10-04T06:37:29.688401Z","end":"2026-10-04T06:37:30.156532Z","steps":["trace[866474134] 'agreement among raft nodes before linearized reading'  (duration: 468.001418ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:30.156605Z","caller":"traceutil/trace.go:171","msg":"trace[1414126347] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:25481; }","duration":"324.210729ms","start":"2026-10-04T06:37:29.832374Z","end":"2026-10-04T06:37:30.156584Z","steps":["trace[1414126347] 'agreement among raft nodes before linearized reading'  (duration: 324.138267ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.688389Z","time spent":"468.218273ms","remote":"127.0.0.1:33060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T06:37:30.15665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.832349Z","time spent":"324.28874ms","remote":"127.0.0.1:51932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":32,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T06:37:30.156656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.38905ms","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-04T06:37:30.15669Z","caller":"traceutil/trace.go:171","msg":"trace[546448708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25481; }","duration":"449.460492ms","start":"2026-10-04T06:37:29.707219Z","end":"2026-10-04T06:37:30.15668Z","steps":["trace[546448708] 'agreement among raft nodes before linearized reading'  (duration: 449.37752ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.707197Z","time spent":"449.511154ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-10-04T06:37:30.156528Z","caller":"traceutil/trace.go:171","msg":"trace[1039756276] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25481; }","duration":"459.929951ms","start":"2026-10-04T06:37:29.696583Z","end":"2026-10-04T06:37:30.156513Z","steps":["trace[1039756276] 'agreement among raft nodes before linearized reading'  (duration: 459.808018ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.322185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-10-04T06:37:30.15677Z","caller":"traceutil/trace.go:171","msg":"trace[1000477269] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25481; }","duration":"351.367756ms","start":"2026-10-04T06:37:29.805388Z","end":"2026-10-04T06:37:30.156756Z","steps":["trace[1000477269] 'agreement among raft nodes before linearized reading'  (duration: 351.210252ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.696573Z","time spent":"460.181777ms","remote":"127.0.0.1:47922","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":"info","ts":"2026-10-04T06:37:30.156564Z","caller":"traceutil/trace.go:171","msg":"trace[1389270843] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25481; }","duration":"428.847343ms","start":"2026-10-04T06:37:29.7277Z","end":"2026-10-04T06:37:30.156548Z","steps":["trace[1389270843] 'agreement among raft nodes before linearized reading'  (duration: 428.664748ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:30.156804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.805334Z","time spent":"351.462548ms","remote":"127.0.0.1:47824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1884,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"warn","ts":"2026-10-04T06:37:30.156578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.707041Z","time spent":"449.529254ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-04T06:37:30.156904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:29.727676Z","time spent":"429.186682ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10382,"request content":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" "}
{"level":"info","ts":"2026-10-04T06:37:30.291897Z","caller":"traceutil/trace.go:171","msg":"trace[777978127] transaction","detail":"{read_only:false; response_revision:25482; number_of_response:1; }","duration":"130.891368ms","start":"2026-10-04T06:37:30.160983Z","end":"2026-10-04T06:37:30.291874Z","steps":["trace[777978127] 'process raft request'  (duration: 107.885379ms)","trace[777978127] 'compare'  (duration: 22.894907ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:30.293671Z","caller":"traceutil/trace.go:171","msg":"trace[1166468406] transaction","detail":"{read_only:false; response_revision:25483; number_of_response:1; }","duration":"132.645394ms","start":"2026-10-04T06:37:30.161003Z","end":"2026-10-04T06:37:30.293648Z","steps":["trace[1166468406] 'process raft request'  (duration: 131.856124ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:30.293858Z","caller":"traceutil/trace.go:171","msg":"trace[229301284] transaction","detail":"{read_only:false; response_revision:25484; number_of_response:1; }","duration":"131.466313ms","start":"2026-10-04T06:37:30.162382Z","end":"2026-10-04T06:37:30.293849Z","steps":["trace[229301284] 'process raft request'  (duration: 130.606412ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:30.29411Z","caller":"traceutil/trace.go:171","msg":"trace[75492622] transaction","detail":"{read_only:false; response_revision:25485; number_of_response:1; }","duration":"125.380307ms","start":"2026-10-04T06:37:30.168719Z","end":"2026-10-04T06:37:30.294099Z","steps":["trace[75492622] 'process raft request'  (duration: 124.32076ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:35.674725Z","caller":"traceutil/trace.go:171","msg":"trace[1261736963] transaction","detail":"{read_only:false; response_revision:25533; number_of_response:1; }","duration":"179.136527ms","start":"2026-10-04T06:37:35.495561Z","end":"2026-10-04T06:37:35.674697Z","steps":["trace[1261736963] 'process raft request'  (duration: 178.934182ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:35.678797Z","caller":"traceutil/trace.go:171","msg":"trace[68803218] transaction","detail":"{read_only:false; response_revision:25534; number_of_response:1; }","duration":"162.879949ms","start":"2026-10-04T06:37:35.515891Z","end":"2026-10-04T06:37:35.678771Z","steps":["trace[68803218] 'process raft request'  (duration: 162.766256ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:40.309591Z","caller":"traceutil/trace.go:171","msg":"trace[1112075326] transaction","detail":"{read_only:false; response_revision:25569; number_of_response:1; }","duration":"121.125827ms","start":"2026-10-04T06:37:40.188432Z","end":"2026-10-04T06:37:40.309558Z","steps":["trace[1112075326] 'process raft request'  (duration: 121.012544ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:40.309584Z","caller":"traceutil/trace.go:171","msg":"trace[311750246] transaction","detail":"{read_only:false; response_revision:25568; number_of_response:1; }","duration":"123.358465ms","start":"2026-10-04T06:37:40.186177Z","end":"2026-10-04T06:37:40.309535Z","steps":["trace[311750246] 'process raft request'  (duration: 123.141009ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:40.843254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5320898529560331688,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-10-04T06:37:41.000697Z","caller":"traceutil/trace.go:171","msg":"trace[2016728155] transaction","detail":"{read_only:false; response_revision:25570; number_of_response:1; }","duration":"685.984851ms","start":"2026-10-04T06:37:40.314678Z","end":"2026-10-04T06:37:41.000663Z","steps":["trace[2016728155] 'process raft request'  (duration: 685.786996ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.001002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.314591Z","time spent":"686.317559ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25554 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T06:37:41.186534Z","caller":"traceutil/trace.go:171","msg":"trace[601303710] transaction","detail":"{read_only:false; response_revision:25571; number_of_response:1; }","duration":"853.247622ms","start":"2026-10-04T06:37:40.333262Z","end":"2026-10-04T06:37:41.18651Z","steps":["trace[601303710] 'process raft request'  (duration: 853.049017ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.186673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.333243Z","time spent":"853.357274ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25556 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T06:37:41.18697Z","caller":"traceutil/trace.go:171","msg":"trace[474235774] transaction","detail":"{read_only:false; response_revision:25572; number_of_response:1; }","duration":"853.641951ms","start":"2026-10-04T06:37:40.333277Z","end":"2026-10-04T06:37:41.186919Z","steps":["trace[474235774] 'process raft request'  (duration: 853.19112ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:41.187094Z","caller":"traceutil/trace.go:171","msg":"trace[943824786] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"377.924717ms","start":"2026-10-04T06:37:40.809148Z","end":"2026-10-04T06:37:41.18708Z","steps":["trace[943824786] 'process raft request'  (duration: 377.767743ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:41.187119Z","caller":"traceutil/trace.go:171","msg":"trace[622874910] linearizableReadLoop","detail":"{readStateIndex:26404; appliedIndex:26396; }","duration":"844.064357ms","start":"2026-10-04T06:37:40.343036Z","end":"2026-10-04T06:37:41.1871Z","steps":["trace[622874910] 'read index received'  (duration: 657.405738ms)","trace[622874910] 'applied index is now lower than readState.Index'  (duration: 186.654628ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:41.18713Z","caller":"traceutil/trace.go:171","msg":"trace[408895812] transaction","detail":"{read_only:false; response_revision:25574; number_of_response:1; }","duration":"503.156299ms","start":"2026-10-04T06:37:40.683944Z","end":"2026-10-04T06:37:41.1871Z","steps":["trace[408895812] 'process raft request'  (duration: 502.924283ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:41.187126Z","caller":"traceutil/trace.go:171","msg":"trace[2023110738] transaction","detail":"{read_only:false; response_revision:25573; number_of_response:1; }","duration":"539.820099ms","start":"2026-10-04T06:37:40.647238Z","end":"2026-10-04T06:37:41.187058Z","steps":["trace[2023110738] 'process raft request'  (duration: 539.532932ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.809121Z","time spent":"378.010629ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25562 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:41.187206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.333254Z","time spent":"853.835806ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25555 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-04T06:37:41.187235Z","caller":"traceutil/trace.go:171","msg":"trace[1349114364] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"346.10869ms","start":"2026-10-04T06:37:40.84111Z","end":"2026-10-04T06:37:41.187219Z","steps":["trace[1349114364] 'process raft request'  (duration: 345.858943ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.683925Z","time spent":"503.265292ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25534 > 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-04T06:37:41.187278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.647209Z","time spent":"539.994974ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:25493 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:41.187315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.841086Z","time spent":"346.178872ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25564 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-10-04T06:37:41.187415Z","caller":"traceutil/trace.go:171","msg":"trace[578441942] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"344.940731ms","start":"2026-10-04T06:37:40.842438Z","end":"2026-10-04T06:37:41.187379Z","steps":["trace[578441942] 'process raft request'  (duration: 344.570821ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.028767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:41.187512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.842413Z","time spent":"345.047994ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25565 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-04T06:37:41.187529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.073008ms","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-04T06:37:41.18757Z","caller":"traceutil/trace.go:171","msg":"trace[923669650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25577; }","duration":"830.112219ms","start":"2026-10-04T06:37:40.357446Z","end":"2026-10-04T06:37:41.187558Z","steps":["trace[923669650] 'agreement among raft nodes before linearized reading'  (duration: 829.992446ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.377834ms","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":"warn","ts":"2026-10-04T06:37:41.187593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.425325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:37:41.187629Z","caller":"traceutil/trace.go:171","msg":"trace[691860815] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:25577; }","duration":"181.465287ms","start":"2026-10-04T06:37:41.006154Z","end":"2026-10-04T06:37:41.187619Z","steps":["trace[691860815] 'agreement among raft nodes before linearized reading'  (duration: 181.396235ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:41.187644Z","caller":"traceutil/trace.go:171","msg":"trace[465414700] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:25577; }","duration":"713.524357ms","start":"2026-10-04T06:37:40.474111Z","end":"2026-10-04T06:37:41.187636Z","steps":["trace[465414700] 'agreement among raft nodes before linearized reading'  (duration: 713.442155ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.357405Z","time spent":"830.190261ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-10-04T06:37:41.187665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.474092Z","time spent":"713.567169ms","remote":"127.0.0.1:33046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T06:37:41.187651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.873712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T06:37:41.187533Z","caller":"traceutil/trace.go:171","msg":"trace[1169570847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25577; }","duration":"671.111519ms","start":"2026-10-04T06:37:40.516408Z","end":"2026-10-04T06:37:41.18752Z","steps":["trace[1169570847] 'agreement among raft nodes before linearized reading'  (duration: 671.026817ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.516394Z","time spent":"671.324604ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-04T06:37:41.187738Z","caller":"traceutil/trace.go:171","msg":"trace[1187805175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25577; }","duration":"844.048097ms","start":"2026-10-04T06:37:40.34366Z","end":"2026-10-04T06:37:41.187708Z","steps":["trace[1187805175] 'agreement among raft nodes before linearized reading'  (duration: 843.766169ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.343639Z","time spent":"844.132349ms","remote":"127.0.0.1:47922","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-04T06:37:41.187485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.435047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-10-04T06:37:41.187799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.69309ms","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-04T06:37:41.187839Z","caller":"traceutil/trace.go:171","msg":"trace[1664117981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25577; }","duration":"844.833957ms","start":"2026-10-04T06:37:40.342986Z","end":"2026-10-04T06:37:41.18782Z","steps":["trace[1664117981] 'agreement among raft nodes before linearized reading'  (duration: 844.375684ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.485206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T06:37:41.187858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.342965Z","time spent":"844.886909ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-10-04T06:37:41.187863Z","caller":"traceutil/trace.go:171","msg":"trace[88401325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25577; }","duration":"840.772921ms","start":"2026-10-04T06:37:40.347078Z","end":"2026-10-04T06:37:41.187851Z","steps":["trace[88401325] 'agreement among raft nodes before linearized reading'  (duration: 840.640378ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:41.187901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:37:40.347069Z","time spent":"840.823393ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-04T06:37:41.187914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.954878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:37:41.187942Z","caller":"traceutil/trace.go:171","msg":"trace[1801563920] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:25577; }","duration":"288.01866ms","start":"2026-10-04T06:37:40.899914Z","end":"2026-10-04T06:37:41.187933Z","steps":["trace[1801563920] 'agreement among raft nodes before linearized reading'  (duration: 287.969888ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:41.187867Z","caller":"traceutil/trace.go:171","msg":"trace[854605819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25577; }","duration":"234.576209ms","start":"2026-10-04T06:37:40.953282Z","end":"2026-10-04T06:37:41.187858Z","steps":["trace[854605819] 'agreement among raft nodes before linearized reading'  (duration: 234.508067ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:42.443Z","caller":"traceutil/trace.go:171","msg":"trace[1778333136] transaction","detail":"{read_only:false; response_revision:25583; number_of_response:1; }","duration":"128.953958ms","start":"2026-10-04T06:37:42.314016Z","end":"2026-10-04T06:37:42.442969Z","steps":["trace[1778333136] 'process raft request'  (duration: 128.756393ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:42.449094Z","caller":"traceutil/trace.go:171","msg":"trace[378057518] linearizableReadLoop","detail":"{readStateIndex:26412; appliedIndex:26410; }","duration":"120.005099ms","start":"2026-10-04T06:37:42.329067Z","end":"2026-10-04T06:37:42.449072Z","steps":["trace[378057518] 'read index received'  (duration: 113.691867ms)","trace[378057518] 'applied index is now lower than readState.Index'  (duration: 6.311992ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:42.449201Z","caller":"traceutil/trace.go:171","msg":"trace[1415462198] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"133.548497ms","start":"2026-10-04T06:37:42.315642Z","end":"2026-10-04T06:37:42.44919Z","steps":["trace[1415462198] 'process raft request'  (duration: 133.28892ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:37:42.449481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.381529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:37:42.449566Z","caller":"traceutil/trace.go:171","msg":"trace[1929783434] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:25584; }","duration":"120.523303ms","start":"2026-10-04T06:37:42.329022Z","end":"2026-10-04T06:37:42.449546Z","steps":["trace[1929783434] 'agreement among raft nodes before linearized reading'  (duration: 120.342738ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:50.311879Z","caller":"traceutil/trace.go:171","msg":"trace[668328106] transaction","detail":"{read_only:false; response_revision:25652; number_of_response:1; }","duration":"239.859815ms","start":"2026-10-04T06:37:50.071971Z","end":"2026-10-04T06:37:50.311831Z","steps":["trace[668328106] 'process raft request'  (duration: 239.552536ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:37:52.639141Z","caller":"traceutil/trace.go:171","msg":"trace[600324350] transaction","detail":"{read_only:false; response_revision:25669; number_of_response:1; }","duration":"137.313733ms","start":"2026-10-04T06:37:52.501801Z","end":"2026-10-04T06:37:52.639115Z","steps":["trace[600324350] 'process raft request'  (duration: 79.213923ms)","trace[600324350] 'compare'  (duration: 57.992307ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:37:53.453534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22259}
{"level":"info","ts":"2026-10-04T06:37:53.574315Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22259,"took":"116.95104ms","hash":3879463646,"current-db-size-bytes":57384960,"current-db-size":"57 MB","current-db-size-in-use-bytes":45244416,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-10-04T06:37:53.574388Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3879463646,"revision":22259,"compact-revision":19912}
{"level":"warn","ts":"2026-10-04T06:37:55.521304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.599993ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560332004 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25679 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:37:55.521423Z","caller":"traceutil/trace.go:171","msg":"trace[1287726946] transaction","detail":"{read_only:false; response_revision:25694; number_of_response:1; }","duration":"151.304922ms","start":"2026-10-04T06:37:55.370097Z","end":"2026-10-04T06:37:55.521402Z","steps":["trace[1287726946] 'process raft request'  (duration: 23.311479ms)","trace[1287726946] 'compare'  (duration: 127.279965ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:38:06.140463Z","caller":"traceutil/trace.go:171","msg":"trace[1948936883] transaction","detail":"{read_only:false; response_revision:25768; number_of_response:1; }","duration":"109.621243ms","start":"2026-10-04T06:38:06.030816Z","end":"2026-10-04T06:38:06.140437Z","steps":["trace[1948936883] 'process raft request'  (duration: 109.460809ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:06.437704Z","caller":"traceutil/trace.go:171","msg":"trace[261396664] transaction","detail":"{read_only:false; response_revision:25769; number_of_response:1; }","duration":"140.387212ms","start":"2026-10-04T06:38:06.297258Z","end":"2026-10-04T06:38:06.437645Z","steps":["trace[261396664] 'process raft request'  (duration: 140.055764ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:06.894831Z","caller":"traceutil/trace.go:171","msg":"trace[1685214935] linearizableReadLoop","detail":"{readStateIndex:26605; appliedIndex:26604; }","duration":"208.166411ms","start":"2026-10-04T06:38:06.686619Z","end":"2026-10-04T06:38:06.894786Z","steps":["trace[1685214935] 'read index received'  (duration: 186.272659ms)","trace[1685214935] 'applied index is now lower than readState.Index'  (duration: 21.892602ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:38:06.895098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.463038ms","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-04T06:38:06.895362Z","caller":"traceutil/trace.go:171","msg":"trace[363154241] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25771; }","duration":"208.766536ms","start":"2026-10-04T06:38:06.686568Z","end":"2026-10-04T06:38:06.895334Z","steps":["trace[363154241] 'agreement among raft nodes before linearized reading'  (duration: 208.457768ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:06.895111Z","caller":"traceutil/trace.go:171","msg":"trace[566234170] transaction","detail":"{read_only:false; response_revision:25771; number_of_response:1; }","duration":"210.1099ms","start":"2026-10-04T06:38:06.684931Z","end":"2026-10-04T06:38:06.895041Z","steps":["trace[566234170] 'process raft request'  (duration: 187.981772ms)","trace[566234170] 'compare'  (duration: 21.636906ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:38:11.743938Z","caller":"traceutil/trace.go:171","msg":"trace[91426122] transaction","detail":"{read_only:false; response_revision:25803; number_of_response:1; }","duration":"301.31606ms","start":"2026-10-04T06:38:11.442596Z","end":"2026-10-04T06:38:11.743912Z","steps":["trace[91426122] 'process raft request'  (duration: 240.925452ms)","trace[91426122] 'compare'  (duration: 60.225794ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:38:11.744085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:38:11.442567Z","time spent":"301.452964ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25789 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-04T06:38:11.744244Z","caller":"traceutil/trace.go:171","msg":"trace[917711853] transaction","detail":"{read_only:false; response_revision:25804; number_of_response:1; }","duration":"300.556021ms","start":"2026-10-04T06:38:11.443656Z","end":"2026-10-04T06:38:11.744212Z","steps":["trace[917711853] 'process raft request'  (duration: 300.217102ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.744454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.276573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:38:11.744525Z","caller":"traceutil/trace.go:171","msg":"trace[154681678] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:25807; }","duration":"284.367415ms","start":"2026-10-04T06:38:11.460144Z","end":"2026-10-04T06:38:11.744512Z","steps":["trace[154681678] 'agreement among raft nodes before linearized reading'  (duration: 284.218152ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:11.744303Z","caller":"traceutil/trace.go:171","msg":"trace[1105167373] linearizableReadLoop","detail":"{readStateIndex:26642; appliedIndex:26637; }","duration":"284.12847ms","start":"2026-10-04T06:38:11.460151Z","end":"2026-10-04T06:38:11.744279Z","steps":["trace[1105167373] 'read index received'  (duration: 68.918658ms)","trace[1105167373] 'applied index is now lower than readState.Index'  (duration: 215.208762ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:38:11.744398Z","caller":"traceutil/trace.go:171","msg":"trace[747565592] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"289.886477ms","start":"2026-10-04T06:38:11.454481Z","end":"2026-10-04T06:38:11.744368Z","steps":["trace[747565592] 'process raft request'  (duration: 289.707572ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.744708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T06:38:11.443636Z","time spent":"300.863919ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25769 > 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-04T06:38:11.744784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.365058ms","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-04T06:38:11.744832Z","caller":"traceutil/trace.go:171","msg":"trace[1873319015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25807; }","duration":"258.45096ms","start":"2026-10-04T06:38:11.486368Z","end":"2026-10-04T06:38:11.744819Z","steps":["trace[1873319015] 'agreement among raft nodes before linearized reading'  (duration: 258.308057ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.744871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.236164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:38:11.744918Z","caller":"traceutil/trace.go:171","msg":"trace[1456098788] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:25807; }","duration":"157.353218ms","start":"2026-10-04T06:38:11.58755Z","end":"2026-10-04T06:38:11.744903Z","steps":["trace[1456098788] 'agreement among raft nodes before linearized reading'  (duration: 157.218154ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:11.744425Z","caller":"traceutil/trace.go:171","msg":"trace[1505363490] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"284.514349ms","start":"2026-10-04T06:38:11.459879Z","end":"2026-10-04T06:38:11.744393Z","steps":["trace[1505363490] 'process raft request'  (duration: 284.355755ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.745023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.826685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-10-04T06:38:11.745059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.605036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T06:38:11.745067Z","caller":"traceutil/trace.go:171","msg":"trace[703258289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25807; }","duration":"257.888626ms","start":"2026-10-04T06:38:11.487168Z","end":"2026-10-04T06:38:11.745056Z","steps":["trace[703258289] 'agreement among raft nodes before linearized reading'  (duration: 257.752713ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.745058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.140803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T06:38:11.745092Z","caller":"traceutil/trace.go:171","msg":"trace[181455070] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25807; }","duration":"258.654577ms","start":"2026-10-04T06:38:11.486425Z","end":"2026-10-04T06:38:11.745079Z","steps":["trace[181455070] 'agreement among raft nodes before linearized reading'  (duration: 258.511883ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:11.745117Z","caller":"traceutil/trace.go:171","msg":"trace[89412702] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:25807; }","duration":"249.258455ms","start":"2026-10-04T06:38:11.495844Z","end":"2026-10-04T06:38:11.745103Z","steps":["trace[89412702] 'agreement among raft nodes before linearized reading'  (duration: 249.156773ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:11.744428Z","caller":"traceutil/trace.go:171","msg":"trace[342441349] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"290.00253ms","start":"2026-10-04T06:38:11.454399Z","end":"2026-10-04T06:38:11.744402Z","steps":["trace[342441349] 'process raft request'  (duration: 289.679492ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.745423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.86229ms","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-04T06:38:11.7455Z","caller":"traceutil/trace.go:171","msg":"trace[630523168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25807; }","duration":"134.984113ms","start":"2026-10-04T06:38:11.610498Z","end":"2026-10-04T06:38:11.745482Z","steps":["trace[630523168] 'agreement among raft nodes before linearized reading'  (duration: 134.536042ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:11.981845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.961695ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560332289 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25796 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:38:11.982094Z","caller":"traceutil/trace.go:171","msg":"trace[1314179091] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"231.459728ms","start":"2026-10-04T06:38:11.750617Z","end":"2026-10-04T06:38:11.982077Z","steps":["trace[1314179091] 'process raft request'  (duration: 231.415627ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:11.982178Z","caller":"traceutil/trace.go:171","msg":"trace[596747747] transaction","detail":"{read_only:false; response_revision:25810; number_of_response:1; }","duration":"231.820528ms","start":"2026-10-04T06:38:11.750326Z","end":"2026-10-04T06:38:11.982146Z","steps":["trace[596747747] 'process raft request'  (duration: 231.649584ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:11.982549Z","caller":"traceutil/trace.go:171","msg":"trace[362405170] transaction","detail":"{read_only:false; response_revision:25809; number_of_response:1; }","duration":"232.068595ms","start":"2026-10-04T06:38:11.750231Z","end":"2026-10-04T06:38:11.9823Z","steps":["trace[362405170] 'process raft request'  (duration: 115.575546ms)","trace[362405170] 'compare'  (duration: 115.590906ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:38:12.22193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.282396ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560332293 > lease_revoke:<id:49d7a105745786f7>","response":"size:30"}
{"level":"info","ts":"2026-10-04T06:38:12.222744Z","caller":"traceutil/trace.go:171","msg":"trace[17305824] linearizableReadLoop","detail":"{readStateIndex:26648; appliedIndex:26647; }","duration":"157.551053ms","start":"2026-10-04T06:38:12.065133Z","end":"2026-10-04T06:38:12.222684Z","steps":["trace[17305824] 'read index received'  (duration: 6.391764ms)","trace[17305824] 'applied index is now lower than readState.Index'  (duration: 151.156468ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:38:12.2237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.208339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T06:38:12.223748Z","caller":"traceutil/trace.go:171","msg":"trace[1453708672] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:25812; }","duration":"158.64273ms","start":"2026-10-04T06:38:12.065093Z","end":"2026-10-04T06:38:12.223736Z","steps":["trace[1453708672] 'agreement among raft nodes before linearized reading'  (duration: 157.825279ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:22.960804Z","caller":"traceutil/trace.go:171","msg":"trace[1500500789] linearizableReadLoop","detail":"{readStateIndex:26736; appliedIndex:26735; }","duration":"136.04651ms","start":"2026-10-04T06:38:22.824735Z","end":"2026-10-04T06:38:22.960781Z","steps":["trace[1500500789] 'read index received'  (duration: 135.882566ms)","trace[1500500789] 'applied index is now lower than readState.Index'  (duration: 163.324µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:38:22.960887Z","caller":"traceutil/trace.go:171","msg":"trace[1394805474] transaction","detail":"{read_only:false; response_revision:25898; number_of_response:1; }","duration":"142.912486ms","start":"2026-10-04T06:38:22.817932Z","end":"2026-10-04T06:38:22.960845Z","steps":["trace[1394805474] 'process raft request'  (duration: 142.745322ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:22.96097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.212284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:972"}
{"level":"info","ts":"2026-10-04T06:38:22.960995Z","caller":"traceutil/trace.go:171","msg":"trace[383497909] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:25898; }","duration":"136.305476ms","start":"2026-10-04T06:38:22.824682Z","end":"2026-10-04T06:38:22.960987Z","steps":["trace[383497909] 'agreement among raft nodes before linearized reading'  (duration: 136.186103ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:23.417057Z","caller":"traceutil/trace.go:171","msg":"trace[447107696] transaction","detail":"{read_only:false; response_revision:25900; number_of_response:1; }","duration":"124.441962ms","start":"2026-10-04T06:38:23.292591Z","end":"2026-10-04T06:38:23.417033Z","steps":["trace[447107696] 'process raft request'  (duration: 124.290988ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:23.97667Z","caller":"traceutil/trace.go:171","msg":"trace[205634010] transaction","detail":"{read_only:false; response_revision:25903; number_of_response:1; }","duration":"144.481628ms","start":"2026-10-04T06:38:23.832165Z","end":"2026-10-04T06:38:23.976646Z","steps":["trace[205634010] 'process raft request'  (duration: 144.283283ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:23.977003Z","caller":"traceutil/trace.go:171","msg":"trace[1160940422] linearizableReadLoop","detail":"{readStateIndex:26743; appliedIndex:26740; }","duration":"129.432511ms","start":"2026-10-04T06:38:23.847558Z","end":"2026-10-04T06:38:23.976991Z","steps":["trace[1160940422] 'read index received'  (duration: 43.504556ms)","trace[1160940422] 'applied index is now lower than readState.Index'  (duration: 85.927065ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T06:38:23.977074Z","caller":"traceutil/trace.go:171","msg":"trace[1516529412] transaction","detail":"{read_only:false; response_revision:25904; number_of_response:1; }","duration":"144.232991ms","start":"2026-10-04T06:38:23.832806Z","end":"2026-10-04T06:38:23.977038Z","steps":["trace[1516529412] 'process raft request'  (duration: 143.803761ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:23.977109Z","caller":"traceutil/trace.go:171","msg":"trace[168988879] transaction","detail":"{read_only:false; response_revision:25905; number_of_response:1; }","duration":"143.494941ms","start":"2026-10-04T06:38:23.833583Z","end":"2026-10-04T06:38:23.977078Z","steps":["trace[168988879] 'process raft request'  (duration: 143.353978ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:23.977176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.599135ms","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-04T06:38:23.977206Z","caller":"traceutil/trace.go:171","msg":"trace[1769959838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25905; }","duration":"129.669216ms","start":"2026-10-04T06:38:23.847528Z","end":"2026-10-04T06:38:23.977197Z","steps":["trace[1769959838] 'agreement among raft nodes before linearized reading'  (duration: 129.539323ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T06:38:24.178013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.701724ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5320898529560332508 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25892 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T06:38:24.178103Z","caller":"traceutil/trace.go:171","msg":"trace[438914136] linearizableReadLoop","detail":"{readStateIndex:26744; appliedIndex:26743; }","duration":"116.606372ms","start":"2026-10-04T06:38:24.061481Z","end":"2026-10-04T06:38:24.178088Z","steps":["trace[438914136] 'read index received'  (duration: 48.111µs)","trace[438914136] 'applied index is now lower than readState.Index'  (duration: 116.556961ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:38:24.17843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.729908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-10-04T06:38:24.17841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.926781ms","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-04T06:38:24.178463Z","caller":"traceutil/trace.go:171","msg":"trace[527432153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25906; }","duration":"106.860561ms","start":"2026-10-04T06:38:24.071593Z","end":"2026-10-04T06:38:24.178453Z","steps":["trace[527432153] 'agreement among raft nodes before linearized reading'  (duration: 106.722528ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:24.178491Z","caller":"traceutil/trace.go:171","msg":"trace[1908098834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25906; }","duration":"117.049064ms","start":"2026-10-04T06:38:24.06142Z","end":"2026-10-04T06:38:24.178469Z","steps":["trace[1908098834] 'agreement among raft nodes before linearized reading'  (duration: 116.828938ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:38:24.178658Z","caller":"traceutil/trace.go:171","msg":"trace[1081019243] transaction","detail":"{read_only:false; response_revision:25906; number_of_response:1; }","duration":"197.043475ms","start":"2026-10-04T06:38:23.981588Z","end":"2026-10-04T06:38:24.178631Z","steps":["trace[1081019243] 'process raft request'  (duration: 79.649893ms)","trace[1081019243] 'compare'  (duration: 116.54695ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T06:38:24.178731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.538284ms","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-04T06:38:24.178808Z","caller":"traceutil/trace.go:171","msg":"trace[606603845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25906; }","duration":"106.629736ms","start":"2026-10-04T06:38:24.072149Z","end":"2026-10-04T06:38:24.178779Z","steps":["trace[606603845] 'agreement among raft nodes before linearized reading'  (duration: 106.442831ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T06:39:22.695555Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006ae5.wal"}
{"level":"info","ts":"2026-10-04T06:42:53.460822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25680}
{"level":"info","ts":"2026-10-04T06:42:53.633541Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25680,"took":"167.742556ms","hash":2787735467,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":35979264,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-04T06:42:53.633599Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2787735467,"revision":25680,"compact-revision":22259}
{"level":"info","ts":"2026-10-04T06:44:06.154404Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca4c710a8d5349d7","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T06:44:06.160387Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-04T06:44:06.160474Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-04T06:47:53.470293Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28550}
{"level":"info","ts":"2026-10-04T06:47:53.621621Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28550,"took":"147.360813ms","hash":1089444726,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":30875648,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T06:47:53.621673Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1089444726,"revision":28550,"compact-revision":25680}
{"level":"info","ts":"2026-10-04T06:52:53.477539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30776}
{"level":"info","ts":"2026-10-04T06:52:53.610688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30776,"took":"129.17243ms","hash":2149660093,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":30384128,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-04T06:52:53.61076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2149660093,"revision":30776,"compact-revision":28550}
{"level":"info","ts":"2026-10-04T06:57:53.486529Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33032}
{"level":"info","ts":"2026-10-04T06:57:53.642646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33032,"took":"151.451352ms","hash":3596824215,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":30801920,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T06:57:53.642734Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3596824215,"revision":33032,"compact-revision":30776}
{"level":"info","ts":"2026-10-04T06:58:51.722169Z","caller":"traceutil/trace.go:171","msg":"trace[1751754601] transaction","detail":"{read_only:false; response_revision:35754; number_of_response:1; }","duration":"102.41313ms","start":"2026-10-04T06:58:51.619677Z","end":"2026-10-04T06:58:51.72209Z","steps":["trace[1751754601] 'process raft request'  (duration: 102.195465ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T07:02:53.49309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35297}
{"level":"info","ts":"2026-10-04T07:02:53.637499Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35297,"took":"139.799913ms","hash":2257252650,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":33067008,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-04T07:02:53.637575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2257252650,"revision":35297,"compact-revision":33032}
{"level":"info","ts":"2026-10-04T07:05:20.036025Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca4c710a8d5349d7","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T07:05:20.043176Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-04T07:05:20.043513Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-04T07:07:53.50035Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37619}
{"level":"info","ts":"2026-10-04T07:07:53.63468Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37619,"took":"130.150867ms","hash":2059127279,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":32731136,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-04T07:07:53.634753Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2059127279,"revision":37619,"compact-revision":35297}
{"level":"info","ts":"2026-10-04T07:12:53.507404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39925}
{"level":"info","ts":"2026-10-04T07:12:53.643387Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39925,"took":"131.574763ms","hash":2746706369,"current-db-size-bytes":59949056,"current-db-size":"60 MB","current-db-size-in-use-bytes":30433280,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-04T07:12:53.643456Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2746706369,"revision":39925,"compact-revision":37619}