{"level":"warn","ts":"2026-07-29T21:52:30.299814Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-29T21:52:30.299943Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-07-29T21:52:30.300005Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-29T21:52:30.300017Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]}
{"level":"info","ts":"2026-07-29T21:52:30.300034Z","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-07-29T21:52:30.300782Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]}
{"level":"info","ts":"2026-07-29T21:52:30.300875Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-07-29T21:52:30.30278Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.668671ms"}
{"level":"info","ts":"2026-07-29T21:52:30.309411Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"}
{"level":"info","ts":"2026-07-29T21:52:30.309503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-29T21:52:30.309529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"}
{"level":"info","ts":"2026-07-29T21:52:30.309548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-29T21:52:30.309564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"}
{"level":"info","ts":"2026-07-29T21:52:30.309605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"}
{"level":"warn","ts":"2026-07-29T21:52:30.313958Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-29T21:52:30.315452Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-29T21:52:30.316566Z","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-07-29T21:52:30.318614Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-29T21:52:30.31879Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-29T21:52:30.318972Z","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-07-29T21:52:30.319062Z","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-07-29T21:52:30.319073Z","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-07-29T21:52:30.320994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"}
{"level":"info","ts":"2026-07-29T21:52:30.321231Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]}
{"level":"info","ts":"2026-07-29T21:52:30.322973Z","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-07-29T21:52:30.323098Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"}
{"level":"info","ts":"2026-07-29T21:52:30.323143Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"}
{"level":"info","ts":"2026-07-29T21:52:30.323207Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-29T21:52:30.32324Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-29T21:52:30.410424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-29T21:52:30.410467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-29T21:52:30.410495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"}
{"level":"info","ts":"2026-07-29T21:52:30.410513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"}
{"level":"info","ts":"2026-07-29T21:52:30.410525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"}
{"level":"info","ts":"2026-07-29T21:52:30.410547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"}
{"level":"info","ts":"2026-07-29T21:52:30.410566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"}
{"level":"info","ts":"2026-07-29T21:52:30.411658Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-29T21:52:30.411818Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-29T21:52:30.411931Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-29T21:52:30.412046Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-29T21:52:30.413421Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-29T21:52:30.413537Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-29T21:52:30.413582Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-29T21:52:30.415985Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"}
{"level":"info","ts":"2026-07-29T21:52:30.415987Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-29T21:52:30.416246Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-29T21:52:30.416343Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-29T21:52:32.436109Z","caller":"traceutil/trace.go:171","msg":"trace[1809488866] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"115.047114ms","start":"2026-07-29T21:52:32.321038Z","end":"2026-07-29T21:52:32.436085Z","steps":["trace[1809488866] 'process raft request'  (duration: 114.927541ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T21:52:47.733972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.916051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-07-29T21:52:47.734054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.307703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"}
{"level":"info","ts":"2026-07-29T21:52:47.734121Z","caller":"traceutil/trace.go:171","msg":"trace[1082500687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:371; }","duration":"107.110466ms","start":"2026-07-29T21:52:47.62699Z","end":"2026-07-29T21:52:47.7341Z","steps":["trace[1082500687] 'range keys from in-memory index tree'  (duration: 106.822188ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:52:47.734194Z","caller":"traceutil/trace.go:171","msg":"trace[1381927287] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:371; }","duration":"239.421605ms","start":"2026-07-29T21:52:47.494712Z","end":"2026-07-29T21:52:47.734134Z","steps":["trace[1381927287] 'range keys from in-memory index tree'  (duration: 239.158079ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:52:47.859456Z","caller":"traceutil/trace.go:171","msg":"trace[81396479] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"121.162939ms","start":"2026-07-29T21:52:47.738262Z","end":"2026-07-29T21:52:47.859425Z","steps":["trace[81396479] 'process raft request'  (duration: 120.956904ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:52:47.871163Z","caller":"traceutil/trace.go:171","msg":"trace[349177538] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"129.418789ms","start":"2026-07-29T21:52:47.741723Z","end":"2026-07-29T21:52:47.871142Z","steps":["trace[349177538] 'process raft request'  (duration: 129.327196ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:53:17.419097Z","caller":"traceutil/trace.go:171","msg":"trace[406448611] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"159.61538ms","start":"2026-07-29T21:53:17.259449Z","end":"2026-07-29T21:53:17.419064Z","steps":["trace[406448611] 'process raft request'  (duration: 112.742807ms)","trace[406448611] 'compare'  (duration: 46.686478ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T21:53:17.427901Z","caller":"traceutil/trace.go:171","msg":"trace[1586420363] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"110.701564ms","start":"2026-07-29T21:53:17.31717Z","end":"2026-07-29T21:53:17.427871Z","steps":["trace[1586420363] 'process raft request'  (duration: 110.573361ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T21:53:17.905304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.904322ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839695382 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp24\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp24\" value_size:2651 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-07-29T21:53:17.907116Z","caller":"traceutil/trace.go:171","msg":"trace[1823082041] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"461.282855ms","start":"2026-07-29T21:53:17.445753Z","end":"2026-07-29T21:53:17.907036Z","steps":["trace[1823082041] 'process raft request'  (duration: 138.109386ms)","trace[1823082041] 'compare'  (duration: 320.742688ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T21:53:17.907495Z","caller":"traceutil/trace.go:171","msg":"trace[823964152] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"279.518708ms","start":"2026-07-29T21:53:17.627945Z","end":"2026-07-29T21:53:17.907464Z","steps":["trace[823964152] 'read index received'  (duration: 27.251µs)","trace[823964152] 'applied index is now lower than readState.Index'  (duration: 279.486867ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T21:53:17.907297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T21:53:17.445733Z","time spent":"461.47661ms","remote":"127.0.0.1:42424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp24\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp24\" value_size:2651 >> failure:<>"}
{"level":"warn","ts":"2026-07-29T21:53:17.907727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.274855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vscf6\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-07-29T21:53:17.907775Z","caller":"traceutil/trace.go:171","msg":"trace[329038094] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vscf6; range_end:; response_count:1; response_revision:603; }","duration":"131.374627ms","start":"2026-07-29T21:53:17.776389Z","end":"2026-07-29T21:53:17.907764Z","steps":["trace[329038094] 'agreement among raft nodes before linearized reading'  (duration: 131.249584ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T21:53:17.907791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.841675ms","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-07-29T21:53:17.907848Z","caller":"traceutil/trace.go:171","msg":"trace[330131314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"279.946088ms","start":"2026-07-29T21:53:17.627888Z","end":"2026-07-29T21:53:17.907834Z","steps":["trace[330131314] 'agreement among raft nodes before linearized reading'  (duration: 279.670241ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T21:53:33.784726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.710867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-07-29T21:53:33.784823Z","caller":"traceutil/trace.go:171","msg":"trace[1269482945] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:765; }","duration":"126.86286ms","start":"2026-07-29T21:53:33.65794Z","end":"2026-07-29T21:53:33.784803Z","steps":["trace[1269482945] 'range keys from in-memory index tree'  (duration: 126.505372ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:54:04.754585Z","caller":"traceutil/trace.go:171","msg":"trace[502344032] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"206.686737ms","start":"2026-07-29T21:54:04.547865Z","end":"2026-07-29T21:54:04.754552Z","steps":["trace[502344032] 'process raft request'  (duration: 206.503103ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:54:52.728304Z","caller":"traceutil/trace.go:171","msg":"trace[709793784] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"289.62494ms","start":"2026-07-29T21:54:52.438642Z","end":"2026-07-29T21:54:52.728267Z","steps":["trace[709793784] 'read index received'  (duration: 196.818347ms)","trace[709793784] 'applied index is now lower than readState.Index'  (duration: 92.805303ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T21:54:52.728416Z","caller":"traceutil/trace.go:171","msg":"trace[1769616559] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"293.123765ms","start":"2026-07-29T21:54:52.435244Z","end":"2026-07-29T21:54:52.728368Z","steps":["trace[1769616559] 'process raft request'  (duration: 200.222119ms)","trace[1769616559] 'compare'  (duration: 92.489965ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T21:54:52.728693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.01387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-07-29T21:54:52.728791Z","caller":"traceutil/trace.go:171","msg":"trace[1293656475] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1844; }","duration":"290.165964ms","start":"2026-07-29T21:54:52.438601Z","end":"2026-07-29T21:54:52.728767Z","steps":["trace[1293656475] 'agreement among raft nodes before linearized reading'  (duration: 289.831906ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T21:59:46.50808Z","caller":"traceutil/trace.go:171","msg":"trace[365932679] transaction","detail":"{read_only:false; response_revision:3864; number_of_response:1; }","duration":"132.867356ms","start":"2026-07-29T21:59:46.37518Z","end":"2026-07-29T21:59:46.508047Z","steps":["trace[365932679] 'process raft request'  (duration: 125.254708ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:14.788402Z","caller":"traceutil/trace.go:171","msg":"trace[1577661404] linearizableReadLoop","detail":"{readStateIndex:5120; appliedIndex:5119; }","duration":"104.365853ms","start":"2026-07-29T22:01:14.684013Z","end":"2026-07-29T22:01:14.788379Z","steps":["trace[1577661404] 'read index received'  (duration: 104.24394ms)","trace[1577661404] 'applied index is now lower than readState.Index'  (duration: 120.713µs)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:14.788465Z","caller":"traceutil/trace.go:171","msg":"trace[260221933] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"110.113662ms","start":"2026-07-29T22:01:14.6783Z","end":"2026-07-29T22:01:14.788413Z","steps":["trace[260221933] 'process raft request'  (duration: 109.926238ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:14.788737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.697972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"}
{"level":"info","ts":"2026-07-29T22:01:14.788838Z","caller":"traceutil/trace.go:171","msg":"trace[1941646180] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4929; }","duration":"104.822185ms","start":"2026-07-29T22:01:14.683996Z","end":"2026-07-29T22:01:14.788818Z","steps":["trace[1941646180] 'agreement among raft nodes before linearized reading'  (duration: 104.515097ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:14.956874Z","caller":"traceutil/trace.go:171","msg":"trace[1748806619] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"159.281141ms","start":"2026-07-29T22:01:14.797559Z","end":"2026-07-29T22:01:14.95684Z","steps":["trace[1748806619] 'process raft request'  (duration: 90.769241ms)","trace[1748806619] 'compare'  (duration: 68.373147ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:14.976955Z","caller":"traceutil/trace.go:171","msg":"trace[1170850175] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5120; }","duration":"172.605037ms","start":"2026-07-29T22:01:14.804316Z","end":"2026-07-29T22:01:14.976921Z","steps":["trace[1170850175] 'read index received'  (duration: 83.974437ms)","trace[1170850175] 'applied index is now lower than readState.Index'  (duration: 88.62896ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:14.97709Z","caller":"traceutil/trace.go:171","msg":"trace[1837270624] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"177.621379ms","start":"2026-07-29T22:01:14.799428Z","end":"2026-07-29T22:01:14.977049Z","steps":["trace[1837270624] 'process raft request'  (duration: 177.299201ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:14.977261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.916424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-07-29T22:01:14.977313Z","caller":"traceutil/trace.go:171","msg":"trace[1237524510] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4931; }","duration":"172.995186ms","start":"2026-07-29T22:01:14.8043Z","end":"2026-07-29T22:01:14.977296Z","steps":["trace[1237524510] 'agreement among raft nodes before linearized reading'  (duration: 172.795741ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:17.531559Z","caller":"traceutil/trace.go:171","msg":"trace[410538473] linearizableReadLoop","detail":"{readStateIndex:5253; appliedIndex:5252; }","duration":"126.551864ms","start":"2026-07-29T22:01:17.404979Z","end":"2026-07-29T22:01:17.531531Z","steps":["trace[410538473] 'read index received'  (duration: 126.321609ms)","trace[410538473] 'applied index is now lower than readState.Index'  (duration: 228.375µs)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:17.531705Z","caller":"traceutil/trace.go:171","msg":"trace[45372137] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"130.06031ms","start":"2026-07-29T22:01:17.401581Z","end":"2026-07-29T22:01:17.531641Z","steps":["trace[45372137] 'process raft request'  (duration: 129.732482ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:17.531841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.757189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-29T22:01:17.531988Z","caller":"traceutil/trace.go:171","msg":"trace[1352798259] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5060; }","duration":"126.964204ms","start":"2026-07-29T22:01:17.404967Z","end":"2026-07-29T22:01:17.531931Z","steps":["trace[1352798259] 'agreement among raft nodes before linearized reading'  (duration: 126.724618ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:17.703726Z","caller":"traceutil/trace.go:171","msg":"trace[527565830] linearizableReadLoop","detail":"{readStateIndex:5254; appliedIndex:5253; }","duration":"172.041762ms","start":"2026-07-29T22:01:17.531652Z","end":"2026-07-29T22:01:17.703694Z","steps":["trace[527565830] 'read index received'  (duration: 170.552916ms)","trace[527565830] 'applied index is now lower than readState.Index'  (duration: 1.487446ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:17.703743Z","caller":"traceutil/trace.go:171","msg":"trace[1271588749] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"231.944352ms","start":"2026-07-29T22:01:17.47176Z","end":"2026-07-29T22:01:17.703704Z","steps":["trace[1271588749] 'process raft request'  (duration: 230.403475ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:17.703945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.343224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-29T22:01:17.703994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.709746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1df441e4-df56-4b6c-95b7-ddcf09dafca0\" ","response":"range_response_count:1 size:3720"}
{"level":"info","ts":"2026-07-29T22:01:17.704019Z","caller":"traceutil/trace.go:171","msg":"trace[817282237] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5061; }","duration":"237.477197ms","start":"2026-07-29T22:01:17.466524Z","end":"2026-07-29T22:01:17.704001Z","steps":["trace[817282237] 'agreement among raft nodes before linearized reading'  (duration: 237.354154ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:17.704035Z","caller":"traceutil/trace.go:171","msg":"trace[876378062] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1df441e4-df56-4b6c-95b7-ddcf09dafca0; range_end:; response_count:1; response_revision:5061; }","duration":"215.806088ms","start":"2026-07-29T22:01:17.488214Z","end":"2026-07-29T22:01:17.70402Z","steps":["trace[876378062] 'agreement among raft nodes before linearized reading'  (duration: 215.618384ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:17.705666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.085035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16453"}
{"level":"info","ts":"2026-07-29T22:01:17.705761Z","caller":"traceutil/trace.go:171","msg":"trace[215909991] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5063; }","duration":"147.257818ms","start":"2026-07-29T22:01:17.558484Z","end":"2026-07-29T22:01:17.705742Z","steps":["trace[215909991] 'agreement among raft nodes before linearized reading'  (duration: 146.970772ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:17.705744Z","caller":"traceutil/trace.go:171","msg":"trace[565201341] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"112.011199ms","start":"2026-07-29T22:01:17.593682Z","end":"2026-07-29T22:01:17.705694Z","steps":["trace[565201341] 'process raft request'  (duration: 111.477616ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:17.705839Z","caller":"traceutil/trace.go:171","msg":"trace[103465484] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"110.607265ms","start":"2026-07-29T22:01:17.595132Z","end":"2026-07-29T22:01:17.705739Z","steps":["trace[103465484] 'process raft request'  (duration: 110.270827ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:31.22521Z","caller":"traceutil/trace.go:171","msg":"trace[1057138745] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"135.197764ms","start":"2026-07-29T22:01:31.089964Z","end":"2026-07-29T22:01:31.225162Z","steps":["trace[1057138745] 'process raft request'  (duration: 62.431111ms)","trace[1057138745] 'compare'  (duration: 72.389684ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:31.529559Z","caller":"traceutil/trace.go:171","msg":"trace[577822853] linearizableReadLoop","detail":"{readStateIndex:5543; appliedIndex:5542; }","duration":"177.26797ms","start":"2026-07-29T22:01:31.352261Z","end":"2026-07-29T22:01:31.529529Z","steps":["trace[577822853] 'read index received'  (duration: 132.832638ms)","trace[577822853] 'applied index is now lower than readState.Index'  (duration: 44.433912ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:31.529675Z","caller":"traceutil/trace.go:171","msg":"trace[963846954] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"259.823151ms","start":"2026-07-29T22:01:31.2698Z","end":"2026-07-29T22:01:31.529623Z","steps":["trace[963846954] 'process raft request'  (duration: 215.195374ms)","trace[963846954] 'compare'  (duration: 44.407721ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:01:31.529756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.479246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-29T22:01:31.529802Z","caller":"traceutil/trace.go:171","msg":"trace[1508837062] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:5341; }","duration":"177.547467ms","start":"2026-07-29T22:01:31.35224Z","end":"2026-07-29T22:01:31.529788Z","steps":["trace[1508837062] 'agreement among raft nodes before linearized reading'  (duration: 177.448395ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:31.529886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.12085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-29T22:01:31.529996Z","caller":"traceutil/trace.go:171","msg":"trace[1649803978] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5341; }","duration":"171.318726ms","start":"2026-07-29T22:01:31.358653Z","end":"2026-07-29T22:01:31.529972Z","steps":["trace[1649803978] 'agreement among raft nodes before linearized reading'  (duration: 171.113961ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:39.811666Z","caller":"traceutil/trace.go:171","msg":"trace[1983864339] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"105.154003ms","start":"2026-07-29T22:01:39.706465Z","end":"2026-07-29T22:01:39.811619Z","steps":["trace[1983864339] 'process raft request'  (duration: 104.833195ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:40.017211Z","caller":"traceutil/trace.go:171","msg":"trace[1407596693] linearizableReadLoop","detail":"{readStateIndex:5744; appliedIndex:5742; }","duration":"183.221914ms","start":"2026-07-29T22:01:39.833955Z","end":"2026-07-29T22:01:40.017177Z","steps":["trace[1407596693] 'read index received'  (duration: 179.008762ms)","trace[1407596693] 'applied index is now lower than readState.Index'  (duration: 4.211162ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:01:40.017336Z","caller":"traceutil/trace.go:171","msg":"trace[1268681231] transaction","detail":"{read_only:false; response_revision:5538; number_of_response:1; }","duration":"198.794434ms","start":"2026-07-29T22:01:39.818492Z","end":"2026-07-29T22:01:40.017287Z","steps":["trace[1268681231] 'process raft request'  (duration: 198.392695ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:40.017512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.397827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18c6e1bbba20f96f\" ","response":"range_response_count:1 size:1012"}
{"level":"info","ts":"2026-07-29T22:01:40.017562Z","caller":"traceutil/trace.go:171","msg":"trace[1042769732] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18c6e1bbba20f96f; range_end:; response_count:1; response_revision:5538; }","duration":"192.49763ms","start":"2026-07-29T22:01:39.825052Z","end":"2026-07-29T22:01:40.01755Z","steps":["trace[1042769732] 'agreement among raft nodes before linearized reading'  (duration: 192.294385ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:40.01759Z","caller":"traceutil/trace.go:171","msg":"trace[1270204126] transaction","detail":"{read_only:false; response_revision:5537; number_of_response:1; }","duration":"199.46579ms","start":"2026-07-29T22:01:39.818057Z","end":"2026-07-29T22:01:40.017523Z","steps":["trace[1270204126] 'process raft request'  (duration: 194.866399ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:01:40.077215Z","caller":"traceutil/trace.go:171","msg":"trace[1302590762] transaction","detail":"{read_only:false; response_revision:5539; number_of_response:1; }","duration":"234.865053ms","start":"2026-07-29T22:01:39.842315Z","end":"2026-07-29T22:01:40.07718Z","steps":["trace[1302590762] 'process raft request'  (duration: 234.682429ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:01:40.077273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.48172ms","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-07-29T22:01:40.077556Z","caller":"traceutil/trace.go:171","msg":"trace[1744957856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5539; }","duration":"107.820418ms","start":"2026-07-29T22:01:39.969719Z","end":"2026-07-29T22:01:40.077539Z","steps":["trace[1744957856] 'agreement among raft nodes before linearized reading'  (duration: 107.416258ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:02:30.758221Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2952}
{"level":"info","ts":"2026-07-29T22:02:30.841468Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2952,"took":"80.614374ms","hash":352402631,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":33665024,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-29T22:02:30.841535Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":352402631,"revision":2952,"compact-revision":-1}
{"level":"info","ts":"2026-07-29T22:07:30.765349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5997}
{"level":"info","ts":"2026-07-29T22:07:30.874513Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5997,"took":"106.747034ms","hash":1852792234,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":21815296,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-07-29T22:07:30.874608Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1852792234,"revision":5997,"compact-revision":2952}
{"level":"info","ts":"2026-07-29T22:07:50.384937Z","caller":"traceutil/trace.go:171","msg":"trace[128676350] transaction","detail":"{read_only:false; response_revision:8356; number_of_response:1; }","duration":"228.606818ms","start":"2026-07-29T22:07:50.156298Z","end":"2026-07-29T22:07:50.384905Z","steps":["trace[128676350] 'process raft request'  (duration: 226.291842ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:08:01.981998Z","caller":"traceutil/trace.go:171","msg":"trace[1770111298] transaction","detail":"{read_only:false; response_revision:8417; number_of_response:1; }","duration":"237.305621ms","start":"2026-07-29T22:08:01.744615Z","end":"2026-07-29T22:08:01.981921Z","steps":["trace[1770111298] 'process raft request'  (duration: 170.942298ms)","trace[1770111298] 'compare'  (duration: 66.036985ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:08:31.831714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.652212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-07-29T22:08:31.83181Z","caller":"traceutil/trace.go:171","msg":"trace[272192392] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8629; }","duration":"431.775075ms","start":"2026-07-29T22:08:31.400013Z","end":"2026-07-29T22:08:31.831788Z","steps":["trace[272192392] 'range keys from in-memory index tree'  (duration: 431.452177ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:08:31.831853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:08:31.400004Z","time spent":"431.838896ms","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5673,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-07-29T22:08:31.852225Z","caller":"traceutil/trace.go:171","msg":"trace[1189846477] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"444.325201ms","start":"2026-07-29T22:08:31.407881Z","end":"2026-07-29T22:08:31.852206Z","steps":["trace[1189846477] 'process raft request'  (duration: 444.196518ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:08:31.85248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:08:31.407857Z","time spent":"444.418914ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8619 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-29T22:08:31.853449Z","caller":"traceutil/trace.go:171","msg":"trace[99270989] transaction","detail":"{read_only:false; response_revision:8634; number_of_response:1; }","duration":"178.037531ms","start":"2026-07-29T22:08:31.675379Z","end":"2026-07-29T22:08:31.853416Z","steps":["trace[99270989] 'process raft request'  (duration: 177.99473ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:08:31.853682Z","caller":"traceutil/trace.go:171","msg":"trace[427653782] transaction","detail":"{read_only:false; response_revision:8631; number_of_response:1; }","duration":"397.239609ms","start":"2026-07-29T22:08:31.456398Z","end":"2026-07-29T22:08:31.853637Z","steps":["trace[427653782] 'process raft request'  (duration: 396.729787ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:08:31.853878Z","caller":"traceutil/trace.go:171","msg":"trace[325576233] transaction","detail":"{read_only:false; response_revision:8632; number_of_response:1; }","duration":"396.505651ms","start":"2026-07-29T22:08:31.457364Z","end":"2026-07-29T22:08:31.85387Z","steps":["trace[325576233] 'process raft request'  (duration: 395.934127ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:08:31.853892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:08:31.456365Z","time spent":"397.419344ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8620 > 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-07-29T22:08:31.854009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:08:31.457342Z","time spent":"396.563623ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8621 > 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-07-29T22:08:31.854036Z","caller":"traceutil/trace.go:171","msg":"trace[449391614] transaction","detail":"{read_only:false; response_revision:8633; number_of_response:1; }","duration":"372.701481ms","start":"2026-07-29T22:08:31.481298Z","end":"2026-07-29T22:08:31.853999Z","steps":["trace[449391614] 'process raft request'  (duration: 372.034284ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:08:31.854197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:08:31.481274Z","time spent":"372.829795ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8521 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-07-29T22:08:44.792232Z","caller":"traceutil/trace.go:171","msg":"trace[1660775752] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"120.72674ms","start":"2026-07-29T22:08:44.671466Z","end":"2026-07-29T22:08:44.792184Z","steps":["trace[1660775752] 'process raft request'  (duration: 120.467984ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:09:00.248559Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f3.wal"}
{"level":"info","ts":"2026-07-29T22:10:03.125127Z","caller":"traceutil/trace.go:171","msg":"trace[1538905631] transaction","detail":"{read_only:false; response_revision:9502; number_of_response:1; }","duration":"106.419927ms","start":"2026-07-29T22:10:03.018678Z","end":"2026-07-29T22:10:03.125098Z","steps":["trace[1538905631] 'process raft request'  (duration: 106.252943ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:10:23.372388Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-29T22:10:23.377188Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-29T22:10:23.377312Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-29T22:12:22.094145Z","caller":"traceutil/trace.go:171","msg":"trace[1952147033] transaction","detail":"{read_only:false; response_revision:10552; number_of_response:1; }","duration":"106.9863ms","start":"2026-07-29T22:12:21.987135Z","end":"2026-07-29T22:12:22.094121Z","steps":["trace[1952147033] 'process raft request'  (duration: 106.838266ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:12:30.774106Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8083}
{"level":"info","ts":"2026-07-29T22:12:30.843568Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8083,"took":"67.572538ms","hash":1892435112,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":29163520,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-07-29T22:12:30.843662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1892435112,"revision":8083,"compact-revision":5997}
{"level":"info","ts":"2026-07-29T22:17:30.78464Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10634}
{"level":"info","ts":"2026-07-29T22:17:30.873354Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10634,"took":"85.116266ms","hash":4137162961,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":27189248,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-07-29T22:17:30.873501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4137162961,"revision":10634,"compact-revision":8083}
{"level":"info","ts":"2026-07-29T22:19:45.662338Z","caller":"traceutil/trace.go:171","msg":"trace[475702267] transaction","detail":"{read_only:false; response_revision:13788; number_of_response:1; }","duration":"129.423245ms","start":"2026-07-29T22:19:45.532886Z","end":"2026-07-29T22:19:45.66231Z","steps":["trace[475702267] 'process raft request'  (duration: 128.704808ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:20:32.111103Z","caller":"traceutil/trace.go:171","msg":"trace[100197359] transaction","detail":"{read_only:false; response_revision:14169; number_of_response:1; }","duration":"112.489073ms","start":"2026-07-29T22:20:31.998577Z","end":"2026-07-29T22:20:32.111066Z","steps":["trace[100197359] 'process raft request'  (duration: 112.215016ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:20:32.375309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.139611ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839729984 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:14051 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-29T22:20:32.375455Z","caller":"traceutil/trace.go:171","msg":"trace[753318371] linearizableReadLoop","detail":"{readStateIndex:14656; appliedIndex:14655; }","duration":"207.948781ms","start":"2026-07-29T22:20:32.167484Z","end":"2026-07-29T22:20:32.375433Z","steps":["trace[753318371] 'read index received'  (duration: 64.471232ms)","trace[753318371] 'applied index is now lower than readState.Index'  (duration: 143.475659ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:20:32.375549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.061434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-29T22:20:32.375605Z","caller":"traceutil/trace.go:171","msg":"trace[1496361746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14170; }","duration":"208.158086ms","start":"2026-07-29T22:20:32.167432Z","end":"2026-07-29T22:20:32.37559Z","steps":["trace[1496361746] 'agreement among raft nodes before linearized reading'  (duration: 208.064824ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:20:32.375517Z","caller":"traceutil/trace.go:171","msg":"trace[2075007801] transaction","detail":"{read_only:false; response_revision:14170; number_of_response:1; }","duration":"260.76288ms","start":"2026-07-29T22:20:32.114718Z","end":"2026-07-29T22:20:32.375481Z","steps":["trace[2075007801] 'process raft request'  (duration: 117.343052ms)","trace[2075007801] 'compare'  (duration: 142.974937ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:22:30.796524Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12806}
{"level":"info","ts":"2026-07-29T22:22:30.876625Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12806,"took":"76.797933ms","hash":1337916731,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":30355456,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-29T22:22:30.876706Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1337916731,"revision":12806,"compact-revision":10634}
{"level":"info","ts":"2026-07-29T22:27:30.802796Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15349}
{"level":"info","ts":"2026-07-29T22:27:30.913513Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15349,"took":"106.851876ms","hash":1122617223,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":31952896,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-29T22:27:30.913598Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1122617223,"revision":15349,"compact-revision":12806}
{"level":"info","ts":"2026-07-29T22:27:48.853087Z","caller":"traceutil/trace.go:171","msg":"trace[1234754271] linearizableReadLoop","detail":"{readStateIndex:18430; appliedIndex:18428; }","duration":"159.035858ms","start":"2026-07-29T22:27:48.694023Z","end":"2026-07-29T22:27:48.853058Z","steps":["trace[1234754271] 'read index received'  (duration: 47.080817ms)","trace[1234754271] 'applied index is now lower than readState.Index'  (duration: 111.953831ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:27:48.853159Z","caller":"traceutil/trace.go:171","msg":"trace[1208795362] transaction","detail":"{read_only:false; response_revision:17825; number_of_response:1; }","duration":"180.79122ms","start":"2026-07-29T22:27:48.672332Z","end":"2026-07-29T22:27:48.853123Z","steps":["trace[1208795362] 'process raft request'  (duration: 142.433455ms)","trace[1208795362] 'compare'  (duration: 38.16683ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:27:48.853429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.386007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-252dce60-43e6-470f-9d10-807f9b07549d\" ","response":"range_response_count:1 size:3759"}
{"level":"info","ts":"2026-07-29T22:27:48.853482Z","caller":"traceutil/trace.go:171","msg":"trace[313228004] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-252dce60-43e6-470f-9d10-807f9b07549d; range_end:; response_count:1; response_revision:17825; }","duration":"159.502831ms","start":"2026-07-29T22:27:48.693962Z","end":"2026-07-29T22:27:48.853465Z","steps":["trace[313228004] 'agreement among raft nodes before linearized reading'  (duration: 159.291426ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:27:48.853519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.886526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"}
{"level":"info","ts":"2026-07-29T22:27:48.853616Z","caller":"traceutil/trace.go:171","msg":"trace[640591260] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:17825; }","duration":"157.02366ms","start":"2026-07-29T22:27:48.696566Z","end":"2026-07-29T22:27:48.85359Z","steps":["trace[640591260] 'agreement among raft nodes before linearized reading'  (duration: 156.753293ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:27:58.560909Z","caller":"traceutil/trace.go:171","msg":"trace[1302561845] transaction","detail":"{read_only:false; response_revision:17910; number_of_response:1; }","duration":"111.321595ms","start":"2026-07-29T22:27:58.449566Z","end":"2026-07-29T22:27:58.560887Z","steps":["trace[1302561845] 'process raft request'  (duration: 111.166032ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:27:58.650388Z","caller":"traceutil/trace.go:171","msg":"trace[1426012376] transaction","detail":"{read_only:false; response_revision:17913; number_of_response:1; }","duration":"174.968349ms","start":"2026-07-29T22:27:58.475389Z","end":"2026-07-29T22:27:58.650357Z","steps":["trace[1426012376] 'process raft request'  (duration: 174.912618ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:27:58.650457Z","caller":"traceutil/trace.go:171","msg":"trace[512838332] transaction","detail":"{read_only:false; response_revision:17911; number_of_response:1; }","duration":"198.254596ms","start":"2026-07-29T22:27:58.452188Z","end":"2026-07-29T22:27:58.650442Z","steps":["trace[512838332] 'process raft request'  (duration: 193.015208ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:27:58.650586Z","caller":"traceutil/trace.go:171","msg":"trace[1885315566] transaction","detail":"{read_only:false; response_revision:17912; number_of_response:1; }","duration":"192.623889ms","start":"2026-07-29T22:27:58.457908Z","end":"2026-07-29T22:27:58.650532Z","steps":["trace[1885315566] 'process raft request'  (duration: 192.343073ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:30:55.315366Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-29T22:30:55.321844Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-29T22:30:55.32195Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-29T22:32:30.807871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17635}
{"level":"info","ts":"2026-07-29T22:32:30.900959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17635,"took":"89.976734ms","hash":279552683,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":34504704,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-29T22:32:30.901016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":279552683,"revision":17635,"compact-revision":15349}
{"level":"warn","ts":"2026-07-29T22:33:19.035036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.623703ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839750550 > lease_revoke:<id:34239fafdd6740bf>","response":"size:28"}
{"level":"info","ts":"2026-07-29T22:33:19.035186Z","caller":"traceutil/trace.go:171","msg":"trace[854107522] linearizableReadLoop","detail":"{readStateIndex:21055; appliedIndex:21054; }","duration":"224.121927ms","start":"2026-07-29T22:33:18.811044Z","end":"2026-07-29T22:33:19.035165Z","steps":["trace[854107522] 'read index received'  (duration: 103.377621ms)","trace[854107522] 'applied index is now lower than readState.Index'  (duration: 120.742666ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:33:19.035484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.409876ms","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-07-29T22:33:19.035592Z","caller":"traceutil/trace.go:171","msg":"trace[2059394917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20365; }","duration":"224.547028ms","start":"2026-07-29T22:33:18.811016Z","end":"2026-07-29T22:33:19.035563Z","steps":["trace[2059394917] 'agreement among raft nodes before linearized reading'  (duration: 224.252211ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:33:29.277826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.152798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:33:29.277936Z","caller":"traceutil/trace.go:171","msg":"trace[1934188303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20418; }","duration":"110.327912ms","start":"2026-07-29T22:33:29.167586Z","end":"2026-07-29T22:33:29.277914Z","steps":["trace[1934188303] 'range keys from in-memory index tree'  (duration: 110.052145ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:33:35.161433Z","caller":"traceutil/trace.go:171","msg":"trace[426402651] linearizableReadLoop","detail":"{readStateIndex:21142; appliedIndex:21141; }","duration":"146.439302ms","start":"2026-07-29T22:33:35.014968Z","end":"2026-07-29T22:33:35.161408Z","steps":["trace[426402651] 'read index received'  (duration: 146.243028ms)","trace[426402651] 'applied index is now lower than readState.Index'  (duration: 195.614µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:33:35.161574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.582516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:33:35.16152Z","caller":"traceutil/trace.go:171","msg":"trace[921685065] transaction","detail":"{read_only:false; response_revision:20448; number_of_response:1; }","duration":"304.657851ms","start":"2026-07-29T22:33:34.856801Z","end":"2026-07-29T22:33:35.161459Z","steps":["trace[921685065] 'process raft request'  (duration: 304.476977ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:33:35.161608Z","caller":"traceutil/trace.go:171","msg":"trace[496981054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20448; }","duration":"146.680968ms","start":"2026-07-29T22:33:35.014919Z","end":"2026-07-29T22:33:35.1616Z","steps":["trace[496981054] 'agreement among raft nodes before linearized reading'  (duration: 146.600346ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:33:35.161729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:33:34.856783Z","time spent":"304.845847ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20437 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-07-29T22:33:35.307967Z","caller":"traceutil/trace.go:171","msg":"trace[487028497] transaction","detail":"{read_only:false; response_revision:20449; number_of_response:1; }","duration":"138.962839ms","start":"2026-07-29T22:33:35.168955Z","end":"2026-07-29T22:33:35.307917Z","steps":["trace[487028497] 'process raft request'  (duration: 107.166994ms)","trace[487028497] 'compare'  (duration: 31.537619ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:33:35.567762Z","caller":"traceutil/trace.go:171","msg":"trace[668168897] transaction","detail":"{read_only:false; response_revision:20452; number_of_response:1; }","duration":"109.05041ms","start":"2026-07-29T22:33:35.458681Z","end":"2026-07-29T22:33:35.567731Z","steps":["trace[668168897] 'process raft request'  (duration: 108.888006ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:33:36.04456Z","caller":"traceutil/trace.go:171","msg":"trace[1635950872] transaction","detail":"{read_only:false; response_revision:20454; number_of_response:1; }","duration":"127.184142ms","start":"2026-07-29T22:33:35.917352Z","end":"2026-07-29T22:33:36.044536Z","steps":["trace[1635950872] 'process raft request'  (duration: 127.057819ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:33:36.04568Z","caller":"traceutil/trace.go:171","msg":"trace[323208712] transaction","detail":"{read_only:false; response_revision:20456; number_of_response:1; }","duration":"124.59864ms","start":"2026-07-29T22:33:35.921058Z","end":"2026-07-29T22:33:36.045657Z","steps":["trace[323208712] 'process raft request'  (duration: 124.556159ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:33:36.045718Z","caller":"traceutil/trace.go:171","msg":"trace[360838553] transaction","detail":"{read_only:false; response_revision:20455; number_of_response:1; }","duration":"126.353772ms","start":"2026-07-29T22:33:35.919353Z","end":"2026-07-29T22:33:36.045707Z","steps":["trace[360838553] 'process raft request'  (duration: 126.160437ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:37:26.808377Z","caller":"traceutil/trace.go:171","msg":"trace[1331897824] transaction","detail":"{read_only:false; response_revision:22882; number_of_response:1; }","duration":"247.466246ms","start":"2026-07-29T22:37:26.560864Z","end":"2026-07-29T22:37:26.80833Z","steps":["trace[1331897824] 'process raft request'  (duration: 245.029637ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:37:30.814511Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20110}
{"level":"info","ts":"2026-07-29T22:37:30.930108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20110,"took":"111.436049ms","hash":498615457,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":42291200,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-07-29T22:37:30.930186Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":498615457,"revision":20110,"compact-revision":17635}
{"level":"info","ts":"2026-07-29T22:40:35.074104Z","caller":"traceutil/trace.go:171","msg":"trace[1538934946] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"193.04357ms","start":"2026-07-29T22:40:34.881018Z","end":"2026-07-29T22:40:35.074062Z","steps":["trace[1538934946] 'process raft request'  (duration: 138.226573ms)","trace[1538934946] 'compare'  (duration: 54.673253ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:35.234641Z","caller":"traceutil/trace.go:171","msg":"trace[671466297] linearizableReadLoop","detail":"{readStateIndex:25678; appliedIndex:25677; }","duration":"174.501457ms","start":"2026-07-29T22:40:35.060104Z","end":"2026-07-29T22:40:35.234606Z","steps":["trace[671466297] 'read index received'  (duration: 114.356001ms)","trace[671466297] 'applied index is now lower than readState.Index'  (duration: 60.144296ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:40:35.23483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.700632ms","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-07-29T22:40:35.234872Z","caller":"traceutil/trace.go:171","msg":"trace[1813704115] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:24861; }","duration":"174.934548ms","start":"2026-07-29T22:40:35.059927Z","end":"2026-07-29T22:40:35.234861Z","steps":["trace[1813704115] 'agreement among raft nodes before linearized reading'  (duration: 174.803814ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:35.235269Z","caller":"traceutil/trace.go:171","msg":"trace[1291547632] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"230.590936ms","start":"2026-07-29T22:40:35.004664Z","end":"2026-07-29T22:40:35.235255Z","steps":["trace[1291547632] 'process raft request'  (duration: 169.872424ms)","trace[1291547632] 'compare'  (duration: 59.921892ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:39.649364Z","caller":"traceutil/trace.go:171","msg":"trace[1513346976] linearizableReadLoop","detail":"{readStateIndex:25711; appliedIndex:25709; }","duration":"151.467826ms","start":"2026-07-29T22:40:39.497871Z","end":"2026-07-29T22:40:39.649339Z","steps":["trace[1513346976] 'read index received'  (duration: 32.809991ms)","trace[1513346976] 'applied index is now lower than readState.Index'  (duration: 118.656645ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:39.649519Z","caller":"traceutil/trace.go:171","msg":"trace[1316561967] transaction","detail":"{read_only:false; response_revision:24893; number_of_response:1; }","duration":"154.745126ms","start":"2026-07-29T22:40:39.494761Z","end":"2026-07-29T22:40:39.649506Z","steps":["trace[1316561967] 'process raft request'  (duration: 153.26451ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:39.649743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.860235ms","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-07-29T22:40:39.649781Z","caller":"traceutil/trace.go:171","msg":"trace[173812177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24896; }","duration":"151.947227ms","start":"2026-07-29T22:40:39.497825Z","end":"2026-07-29T22:40:39.649772Z","steps":["trace[173812177] 'agreement among raft nodes before linearized reading'  (duration: 151.813454ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:39.649958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.298421ms","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-07-29T22:40:39.649983Z","caller":"traceutil/trace.go:171","msg":"trace[1509657713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24896; }","duration":"110.362583ms","start":"2026-07-29T22:40:39.539613Z","end":"2026-07-29T22:40:39.649976Z","steps":["trace[1509657713] 'agreement among raft nodes before linearized reading'  (duration: 110.28681ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:39.779668Z","caller":"traceutil/trace.go:171","msg":"trace[1296774532] transaction","detail":"{read_only:false; response_revision:24898; number_of_response:1; }","duration":"123.298338ms","start":"2026-07-29T22:40:39.656329Z","end":"2026-07-29T22:40:39.779628Z","steps":["trace[1296774532] 'process raft request'  (duration: 115.490137ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:40.062883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.106371ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839762542 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24884 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:40:40.063015Z","caller":"traceutil/trace.go:171","msg":"trace[897485928] linearizableReadLoop","detail":"{readStateIndex:25717; appliedIndex:25716; }","duration":"261.219213ms","start":"2026-07-29T22:40:39.801776Z","end":"2026-07-29T22:40:40.062995Z","steps":["trace[897485928] 'read index received'  (duration: 149.896027ms)","trace[897485928] 'applied index is now lower than readState.Index'  (duration: 111.321466ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:40.063131Z","caller":"traceutil/trace.go:171","msg":"trace[1345461807] transaction","detail":"{read_only:false; response_revision:24899; number_of_response:1; }","duration":"278.760081ms","start":"2026-07-29T22:40:39.784359Z","end":"2026-07-29T22:40:40.063119Z","steps":["trace[1345461807] 'process raft request'  (duration: 167.294461ms)","trace[1345461807] 'compare'  (duration: 110.936357ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:40:40.063197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.4221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:40:40.063197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.403977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-29T22:40:40.063265Z","caller":"traceutil/trace.go:171","msg":"trace[1338059901] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:24899; }","duration":"261.550491ms","start":"2026-07-29T22:40:39.801699Z","end":"2026-07-29T22:40:40.063249Z","steps":["trace[1338059901] 'agreement among raft nodes before linearized reading'  (duration: 261.443039ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:40.06326Z","caller":"traceutil/trace.go:171","msg":"trace[685569843] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24899; }","duration":"175.531613ms","start":"2026-07-29T22:40:39.887712Z","end":"2026-07-29T22:40:40.063244Z","steps":["trace[685569843] 'agreement among raft nodes before linearized reading'  (duration: 175.427521ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:40.411809Z","caller":"traceutil/trace.go:171","msg":"trace[453182258] transaction","detail":"{read_only:false; response_revision:24900; number_of_response:1; }","duration":"125.286046ms","start":"2026-07-29T22:40:40.286495Z","end":"2026-07-29T22:40:40.411781Z","steps":["trace[453182258] 'process raft request'  (duration: 125.113702ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:41.587005Z","caller":"traceutil/trace.go:171","msg":"trace[1006052721] linearizableReadLoop","detail":"{readStateIndex:25722; appliedIndex:25721; }","duration":"201.741162ms","start":"2026-07-29T22:40:41.385239Z","end":"2026-07-29T22:40:41.58698Z","steps":["trace[1006052721] 'read index received'  (duration: 201.696861ms)","trace[1006052721] 'applied index is now lower than readState.Index'  (duration: 43.191µs)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:41.587111Z","caller":"traceutil/trace.go:171","msg":"trace[49735034] transaction","detail":"{read_only:false; response_revision:24904; number_of_response:1; }","duration":"318.393248ms","start":"2026-07-29T22:40:41.268685Z","end":"2026-07-29T22:40:41.587078Z","steps":["trace[49735034] 'process raft request'  (duration: 318.173953ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:41.587257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.268663Z","time spent":"318.514451ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24890 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-29T22:40:41.587254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.008738ms","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-07-29T22:40:41.587318Z","caller":"traceutil/trace.go:171","msg":"trace[1751421830] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24904; }","duration":"202.0804ms","start":"2026-07-29T22:40:41.385223Z","end":"2026-07-29T22:40:41.587304Z","steps":["trace[1751421830] 'agreement among raft nodes before linearized reading'  (duration: 201.877325ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:41.793473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.949212ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839762559 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24857 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:40:41.793612Z","caller":"traceutil/trace.go:171","msg":"trace[1466887344] linearizableReadLoop","detail":"{readStateIndex:25724; appliedIndex:25722; }","duration":"206.523119ms","start":"2026-07-29T22:40:41.587075Z","end":"2026-07-29T22:40:41.793598Z","steps":["trace[1466887344] 'read index received'  (duration: 78.385303ms)","trace[1466887344] 'applied index is now lower than readState.Index'  (duration: 128.137146ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:41.793674Z","caller":"traceutil/trace.go:171","msg":"trace[1496055194] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"257.102653ms","start":"2026-07-29T22:40:41.536555Z","end":"2026-07-29T22:40:41.793658Z","steps":["trace[1496055194] 'process raft request'  (duration: 256.99739ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:41.793699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.032324ms","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-07-29T22:40:41.793721Z","caller":"traceutil/trace.go:171","msg":"trace[188113056] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:24906; }","duration":"312.081365ms","start":"2026-07-29T22:40:41.481631Z","end":"2026-07-29T22:40:41.793712Z","steps":["trace[188113056] 'agreement among raft nodes before linearized reading'  (duration: 312.024224ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:41.793747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.481611Z","time spent":"312.130076ms","remote":"127.0.0.1:42740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:40:41.793884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.802709ms","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-07-29T22:40:41.793897Z","caller":"traceutil/trace.go:171","msg":"trace[1978021331] transaction","detail":"{read_only:false; response_revision:24905; number_of_response:1; }","duration":"391.202005ms","start":"2026-07-29T22:40:41.402662Z","end":"2026-07-29T22:40:41.793864Z","steps":["trace[1978021331] 'process raft request'  (duration: 262.784641ms)","trace[1978021331] 'compare'  (duration: 127.742927ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:41.793909Z","caller":"traceutil/trace.go:171","msg":"trace[504894323] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24906; }","duration":"316.861581ms","start":"2026-07-29T22:40:41.47704Z","end":"2026-07-29T22:40:41.793902Z","steps":["trace[504894323] 'agreement among raft nodes before linearized reading'  (duration: 316.82355ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:41.793933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.477022Z","time spent":"316.905241ms","remote":"127.0.0.1:39294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:40:41.793971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.402634Z","time spent":"391.284777ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24857 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-07-29T22:40:41.794082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.554867ms","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-07-29T22:40:41.794106Z","caller":"traceutil/trace.go:171","msg":"trace[871653247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24906; }","duration":"342.623499ms","start":"2026-07-29T22:40:41.451476Z","end":"2026-07-29T22:40:41.794099Z","steps":["trace[871653247] 'agreement among raft nodes before linearized reading'  (duration: 342.542727ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:41.794126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.451456Z","time spent":"342.66623ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-07-29T22:40:42.070779Z","caller":"traceutil/trace.go:171","msg":"trace[236752823] transaction","detail":"{read_only:false; response_revision:24907; number_of_response:1; }","duration":"416.446071ms","start":"2026-07-29T22:40:41.654242Z","end":"2026-07-29T22:40:42.070688Z","steps":["trace[236752823] 'process raft request'  (duration: 347.836806ms)","trace[236752823] 'compare'  (duration: 68.40079ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:40:42.070969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.654208Z","time spent":"416.662916ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24894 > 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-07-29T22:40:42.071016Z","caller":"traceutil/trace.go:171","msg":"trace[458519464] transaction","detail":"{read_only:false; response_revision:24908; number_of_response:1; }","duration":"415.901578ms","start":"2026-07-29T22:40:41.655096Z","end":"2026-07-29T22:40:42.070997Z","steps":["trace[458519464] 'process raft request'  (duration: 415.521279ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.071132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.655075Z","time spent":"415.99426ms","remote":"127.0.0.1:42504","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:24896 > 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-07-29T22:40:42.071449Z","caller":"traceutil/trace.go:171","msg":"trace[767366474] transaction","detail":"{read_only:false; response_revision:24909; number_of_response:1; }","duration":"415.124728ms","start":"2026-07-29T22:40:41.656307Z","end":"2026-07-29T22:40:42.071432Z","steps":["trace[767366474] 'process raft request'  (duration: 414.624825ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.071545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.656298Z","time spent":"415.19999ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24895 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-29T22:40:42.071979Z","caller":"traceutil/trace.go:171","msg":"trace[527246771] linearizableReadLoop","detail":"{readStateIndex:25728; appliedIndex:25724; }","duration":"278.31956ms","start":"2026-07-29T22:40:41.793636Z","end":"2026-07-29T22:40:42.071956Z","steps":["trace[527246771] 'read index received'  (duration: 208.523527ms)","trace[527246771] 'applied index is now lower than readState.Index'  (duration: 69.794673ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:42.07202Z","caller":"traceutil/trace.go:171","msg":"trace[574951376] transaction","detail":"{read_only:false; response_revision:24910; number_of_response:1; }","duration":"414.79217ms","start":"2026-07-29T22:40:41.657202Z","end":"2026-07-29T22:40:42.071994Z","steps":["trace[574951376] 'process raft request'  (duration: 414.165205ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.072157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.657188Z","time spent":"414.900352ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24893 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-29T22:40:42.07253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.102938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:40:42.072552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.372704ms","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-07-29T22:40:42.072598Z","caller":"traceutil/trace.go:171","msg":"trace[1021772087] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24910; }","duration":"481.444746ms","start":"2026-07-29T22:40:41.591139Z","end":"2026-07-29T22:40:42.072584Z","steps":["trace[1021772087] 'agreement among raft nodes before linearized reading'  (duration: 480.905483ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.072636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.591126Z","time spent":"481.503087ms","remote":"127.0.0.1:42424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-07-29T22:40:42.072606Z","caller":"traceutil/trace.go:171","msg":"trace[1608434665] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:24910; }","duration":"413.202801ms","start":"2026-07-29T22:40:41.659373Z","end":"2026-07-29T22:40:42.072576Z","steps":["trace[1608434665] 'agreement among raft nodes before linearized reading'  (duration: 412.657058ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.072699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.659316Z","time spent":"413.367175ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:40:42.073274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.870647ms","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-07-29T22:40:42.073522Z","caller":"traceutil/trace.go:171","msg":"trace[1238419202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24910; }","duration":"289.597996ms","start":"2026-07-29T22:40:41.783877Z","end":"2026-07-29T22:40:42.073475Z","steps":["trace[1238419202] 'agreement among raft nodes before linearized reading'  (duration: 288.084148ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.07415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.945221ms","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-07-29T22:40:42.074248Z","caller":"traceutil/trace.go:171","msg":"trace[1705409704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24910; }","duration":"387.102954ms","start":"2026-07-29T22:40:41.687131Z","end":"2026-07-29T22:40:42.074233Z","steps":["trace[1705409704] 'agreement among raft nodes before linearized reading'  (duration: 384.89762ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.074328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:41.687106Z","time spent":"387.210027ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-07-29T22:40:42.089342Z","caller":"traceutil/trace.go:171","msg":"trace[1708178863] transaction","detail":"{read_only:false; response_revision:24911; number_of_response:1; }","duration":"276.014944ms","start":"2026-07-29T22:40:41.813318Z","end":"2026-07-29T22:40:42.089333Z","steps":["trace[1708178863] 'process raft request'  (duration: 275.954783ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:42.223211Z","caller":"traceutil/trace.go:171","msg":"trace[1339956812] transaction","detail":"{read_only:false; response_revision:24914; number_of_response:1; }","duration":"129.899249ms","start":"2026-07-29T22:40:42.093285Z","end":"2026-07-29T22:40:42.223184Z","steps":["trace[1339956812] 'process raft request'  (duration: 129.818367ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:42.223798Z","caller":"traceutil/trace.go:171","msg":"trace[258906012] transaction","detail":"{read_only:false; response_revision:24912; number_of_response:1; }","duration":"145.754676ms","start":"2026-07-29T22:40:42.078031Z","end":"2026-07-29T22:40:42.223785Z","steps":["trace[258906012] 'process raft request'  (duration: 142.882476ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:42.224059Z","caller":"traceutil/trace.go:171","msg":"trace[386630544] transaction","detail":"{read_only:false; response_revision:24913; number_of_response:1; }","duration":"145.236903ms","start":"2026-07-29T22:40:42.078811Z","end":"2026-07-29T22:40:42.224048Z","steps":["trace[386630544] 'process raft request'  (duration: 144.158817ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:42.22428Z","caller":"traceutil/trace.go:171","msg":"trace[1076921197] linearizableReadLoop","detail":"{readStateIndex:25731; appliedIndex:25729; }","duration":"134.636304ms","start":"2026-07-29T22:40:42.089603Z","end":"2026-07-29T22:40:42.224239Z","steps":["trace[1076921197] 'read index received'  (duration: 131.325044ms)","trace[1076921197] 'applied index is now lower than readState.Index'  (duration: 3.31005ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:40:42.22502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.23754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18434"}
{"level":"info","ts":"2026-07-29T22:40:42.225083Z","caller":"traceutil/trace.go:171","msg":"trace[350956550] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24914; }","duration":"151.327932ms","start":"2026-07-29T22:40:42.073741Z","end":"2026-07-29T22:40:42.225069Z","steps":["trace[350956550] 'agreement among raft nodes before linearized reading'  (duration: 151.179259ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.583728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.934003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-07-29T22:40:42.583797Z","caller":"traceutil/trace.go:171","msg":"trace[415108296] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24914; }","duration":"258.070706ms","start":"2026-07-29T22:40:42.325708Z","end":"2026-07-29T22:40:42.583779Z","steps":["trace[415108296] 'range keys from in-memory index tree'  (duration: 257.767979ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:42.583874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.868949ms","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-07-29T22:40:42.583953Z","caller":"traceutil/trace.go:171","msg":"trace[967990557] 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:24914; }","duration":"187.006083ms","start":"2026-07-29T22:40:42.396928Z","end":"2026-07-29T22:40:42.583934Z","steps":["trace[967990557] 'range keys from in-memory index tree'  (duration: 186.778507ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:42.604278Z","caller":"traceutil/trace.go:171","msg":"trace[712102594] transaction","detail":"{read_only:false; response_revision:24915; number_of_response:1; }","duration":"186.343906ms","start":"2026-07-29T22:40:42.417906Z","end":"2026-07-29T22:40:42.60425Z","steps":["trace[712102594] 'process raft request'  (duration: 185.859504ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:57.029601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.752381ms","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-07-29T22:40:57.029761Z","caller":"traceutil/trace.go:171","msg":"trace[1875958782] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25077; }","duration":"112.926226ms","start":"2026-07-29T22:40:56.916812Z","end":"2026-07-29T22:40:57.029739Z","steps":["trace[1875958782] 'range keys from in-memory index tree'  (duration: 112.731081ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:57.575907Z","caller":"traceutil/trace.go:171","msg":"trace[1762023801] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"168.753397ms","start":"2026-07-29T22:40:57.407123Z","end":"2026-07-29T22:40:57.575877Z","steps":["trace[1762023801] 'process raft request'  (duration: 168.609183ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:57.889443Z","caller":"traceutil/trace.go:171","msg":"trace[659760016] linearizableReadLoop","detail":"{readStateIndex:25902; appliedIndex:25900; }","duration":"348.234606ms","start":"2026-07-29T22:40:57.541186Z","end":"2026-07-29T22:40:57.88942Z","steps":["trace[659760016] 'read index received'  (duration: 34.534202ms)","trace[659760016] 'applied index is now lower than readState.Index'  (duration: 313.699274ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:40:57.889605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.39834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-29T22:40:57.889587Z","caller":"traceutil/trace.go:171","msg":"trace[171872174] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"480.80075ms","start":"2026-07-29T22:40:57.408756Z","end":"2026-07-29T22:40:57.889557Z","steps":["trace[171872174] 'process raft request'  (duration: 480.512993ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:57.889662Z","caller":"traceutil/trace.go:171","msg":"trace[798097185] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25080; }","duration":"348.517723ms","start":"2026-07-29T22:40:57.541129Z","end":"2026-07-29T22:40:57.889647Z","steps":["trace[798097185] 'agreement among raft nodes before linearized reading'  (duration: 348.413821ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:57.889732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:57.541108Z","time spent":"348.592515ms","remote":"127.0.0.1:42408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:40:57.889889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:57.408725Z","time spent":"481.046267ms","remote":"127.0.0.1:42424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc0bf829-e245-4ac9-b1f0-48a28e19e2e6\" mod_revision:25056 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc0bf829-e245-4ac9-b1f0-48a28e19e2e6\" value_size:3645 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc0bf829-e245-4ac9-b1f0-48a28e19e2e6\" > >"}
{"level":"info","ts":"2026-07-29T22:40:58.13922Z","caller":"traceutil/trace.go:171","msg":"trace[2109314994] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"478.686429ms","start":"2026-07-29T22:40:57.660504Z","end":"2026-07-29T22:40:58.13919Z","steps":["trace[2109314994] 'process raft request'  (duration: 379.277323ms)","trace[2109314994] 'compare'  (duration: 99.004705ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:40:58.139345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:57.660478Z","time spent":"478.798682ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25007 > 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-07-29T22:40:58.139357Z","caller":"traceutil/trace.go:171","msg":"trace[1764929559] linearizableReadLoop","detail":"{readStateIndex:25905; appliedIndex:25902; }","duration":"249.803145ms","start":"2026-07-29T22:40:57.88952Z","end":"2026-07-29T22:40:58.139324Z","steps":["trace[1764929559] 'read index received'  (duration: 150.216495ms)","trace[1764929559] 'applied index is now lower than readState.Index'  (duration: 99.58552ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:58.139441Z","caller":"traceutil/trace.go:171","msg":"trace[1715773007] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"328.907615ms","start":"2026-07-29T22:40:57.810528Z","end":"2026-07-29T22:40:58.139435Z","steps":["trace[1715773007] 'process raft request'  (duration: 328.556837ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.139473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:57.810508Z","time spent":"328.948246ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24987 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-29T22:40:58.139589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.176074ms","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-07-29T22:40:58.139607Z","caller":"traceutil/trace.go:171","msg":"trace[1565925700] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25083; }","duration":"359.234355ms","start":"2026-07-29T22:40:57.780368Z","end":"2026-07-29T22:40:58.139602Z","steps":["trace[1565925700] 'agreement among raft nodes before linearized reading'  (duration: 359.144343ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.139624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:40:57.780347Z","time spent":"359.274306ms","remote":"127.0.0.1:42424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-29T22:40:58.139701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.599175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc0bf829-e245-4ac9-b1f0-48a28e19e2e6\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-07-29T22:40:58.139774Z","caller":"traceutil/trace.go:171","msg":"trace[1026896957] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc0bf829-e245-4ac9-b1f0-48a28e19e2e6; range_end:; response_count:1; response_revision:25083; }","duration":"100.718018ms","start":"2026-07-29T22:40:58.039035Z","end":"2026-07-29T22:40:58.139753Z","steps":["trace[1026896957] 'agreement among raft nodes before linearized reading'  (duration: 100.490462ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.139739Z","caller":"traceutil/trace.go:171","msg":"trace[1219289900] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"264.984505ms","start":"2026-07-29T22:40:57.874749Z","end":"2026-07-29T22:40:58.139734Z","steps":["trace[1219289900] 'process raft request'  (duration: 264.504414ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.414543Z","caller":"traceutil/trace.go:171","msg":"trace[1577022836] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"264.048572ms","start":"2026-07-29T22:40:58.150447Z","end":"2026-07-29T22:40:58.414495Z","steps":["trace[1577022836] 'process raft request'  (duration: 203.146726ms)","trace[1577022836] 'compare'  (duration: 60.628129ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:58.414704Z","caller":"traceutil/trace.go:171","msg":"trace[307812319] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"262.899394ms","start":"2026-07-29T22:40:58.151781Z","end":"2026-07-29T22:40:58.414681Z","steps":["trace[307812319] 'process raft request'  (duration: 262.619028ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.414804Z","caller":"traceutil/trace.go:171","msg":"trace[1076662898] linearizableReadLoop","detail":"{readStateIndex:25909; appliedIndex:25906; }","duration":"251.160388ms","start":"2026-07-29T22:40:58.163607Z","end":"2026-07-29T22:40:58.414767Z","steps":["trace[1076662898] 'read index received'  (duration: 189.937955ms)","trace[1076662898] 'applied index is now lower than readState.Index'  (duration: 61.221103ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:58.414946Z","caller":"traceutil/trace.go:171","msg":"trace[856051615] transaction","detail":"{read_only:false; response_revision:25087; number_of_response:1; }","duration":"262.70672ms","start":"2026-07-29T22:40:58.152231Z","end":"2026-07-29T22:40:58.414938Z","steps":["trace[856051615] 'process raft request'  (duration: 262.417213ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.415095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.709331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:40:58.415115Z","caller":"traceutil/trace.go:171","msg":"trace[765779362] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:25087; }","duration":"119.784233ms","start":"2026-07-29T22:40:58.295323Z","end":"2026-07-29T22:40:58.415108Z","steps":["trace[765779362] 'agreement among raft nodes before linearized reading'  (duration: 119.730221ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.415116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.936414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:40:58.415153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.365712ms","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":"warn","ts":"2026-07-29T22:40:58.415145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.687209ms","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-07-29T22:40:58.415192Z","caller":"traceutil/trace.go:171","msg":"trace[1157593631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25087; }","duration":"249.050006ms","start":"2026-07-29T22:40:58.166122Z","end":"2026-07-29T22:40:58.415172Z","steps":["trace[1157593631] 'agreement among raft nodes before linearized reading'  (duration: 248.906293ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.415211Z","caller":"traceutil/trace.go:171","msg":"trace[39720761] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25087; }","duration":"260.465105ms","start":"2026-07-29T22:40:58.154728Z","end":"2026-07-29T22:40:58.415193Z","steps":["trace[39720761] 'agreement among raft nodes before linearized reading'  (duration: 260.221119ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.41522Z","caller":"traceutil/trace.go:171","msg":"trace[142090360] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25087; }","duration":"271.803672ms","start":"2026-07-29T22:40:58.143399Z","end":"2026-07-29T22:40:58.415203Z","steps":["trace[142090360] 'agreement among raft nodes before linearized reading'  (duration: 271.607227ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.415368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.537275ms","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-07-29T22:40:58.415447Z","caller":"traceutil/trace.go:171","msg":"trace[682765673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25087; }","duration":"112.758871ms","start":"2026-07-29T22:40:58.302669Z","end":"2026-07-29T22:40:58.415428Z","steps":["trace[682765673] 'agreement among raft nodes before linearized reading'  (duration: 112.435724ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.415476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.448702ms","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-07-29T22:40:58.415494Z","caller":"traceutil/trace.go:171","msg":"trace[1701439237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25087; }","duration":"121.496384ms","start":"2026-07-29T22:40:58.293993Z","end":"2026-07-29T22:40:58.415489Z","steps":["trace[1701439237] 'agreement among raft nodes before linearized reading'  (duration: 121.405692ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.415498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.256004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-29T22:40:58.415542Z","caller":"traceutil/trace.go:171","msg":"trace[1777663407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25087; }","duration":"120.320916ms","start":"2026-07-29T22:40:58.295208Z","end":"2026-07-29T22:40:58.415529Z","steps":["trace[1777663407] 'agreement among raft nodes before linearized reading'  (duration: 120.165162ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.607051Z","caller":"traceutil/trace.go:171","msg":"trace[212837861] linearizableReadLoop","detail":"{readStateIndex:25913; appliedIndex:25911; }","duration":"131.17189ms","start":"2026-07-29T22:40:58.475851Z","end":"2026-07-29T22:40:58.607023Z","steps":["trace[212837861] 'read index received'  (duration: 130.816151ms)","trace[212837861] 'applied index is now lower than readState.Index'  (duration: 354.819µs)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:58.607085Z","caller":"traceutil/trace.go:171","msg":"trace[956774789] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"186.267285ms","start":"2026-07-29T22:40:58.420781Z","end":"2026-07-29T22:40:58.607048Z","steps":["trace[956774789] 'process raft request'  (duration: 185.953506ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.607187Z","caller":"traceutil/trace.go:171","msg":"trace[1889027253] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"186.347967ms","start":"2026-07-29T22:40:58.420827Z","end":"2026-07-29T22:40:58.607175Z","steps":["trace[1889027253] 'process raft request'  (duration: 186.124371ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.607439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.540439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:40:58.607521Z","caller":"traceutil/trace.go:171","msg":"trace[1080761719] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25091; }","duration":"131.704513ms","start":"2026-07-29T22:40:58.475798Z","end":"2026-07-29T22:40:58.607503Z","steps":["trace[1080761719] 'agreement among raft nodes before linearized reading'  (duration: 131.519378ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.60845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.776984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-29T22:40:58.608514Z","caller":"traceutil/trace.go:171","msg":"trace[446631063] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25091; }","duration":"108.875247ms","start":"2026-07-29T22:40:58.499625Z","end":"2026-07-29T22:40:58.6085Z","steps":["trace[446631063] 'agreement among raft nodes before linearized reading'  (duration: 107.655697ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:40:58.873283Z","caller":"traceutil/trace.go:171","msg":"trace[1252171627] linearizableReadLoop","detail":"{readStateIndex:25914; appliedIndex:25913; }","duration":"194.359903ms","start":"2026-07-29T22:40:58.678898Z","end":"2026-07-29T22:40:58.873258Z","steps":["trace[1252171627] 'read index received'  (duration: 185.403893ms)","trace[1252171627] 'applied index is now lower than readState.Index'  (duration: 8.95511ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:40:58.873326Z","caller":"traceutil/trace.go:171","msg":"trace[1652203197] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"211.771407ms","start":"2026-07-29T22:40:58.661509Z","end":"2026-07-29T22:40:58.87328Z","steps":["trace[1652203197] 'process raft request'  (duration: 202.789877ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:40:58.87339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.471515ms","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-07-29T22:40:58.873415Z","caller":"traceutil/trace.go:171","msg":"trace[1035256241] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25092; }","duration":"194.555077ms","start":"2026-07-29T22:40:58.678852Z","end":"2026-07-29T22:40:58.873407Z","steps":["trace[1035256241] 'agreement among raft nodes before linearized reading'  (duration: 194.484006ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:00.789799Z","caller":"traceutil/trace.go:171","msg":"trace[557685653] transaction","detail":"{read_only:false; response_revision:25105; number_of_response:1; }","duration":"172.893228ms","start":"2026-07-29T22:41:00.616878Z","end":"2026-07-29T22:41:00.789771Z","steps":["trace[557685653] 'process raft request'  (duration: 164.450902ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:05.574513Z","caller":"traceutil/trace.go:171","msg":"trace[1738828409] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"242.051716ms","start":"2026-07-29T22:41:05.332427Z","end":"2026-07-29T22:41:05.574479Z","steps":["trace[1738828409] 'process raft request'  (duration: 241.894382ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:05.598332Z","caller":"traceutil/trace.go:171","msg":"trace[137115349] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"146.926735ms","start":"2026-07-29T22:41:05.451375Z","end":"2026-07-29T22:41:05.598302Z","steps":["trace[137115349] 'process raft request'  (duration: 146.762271ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:05.739958Z","caller":"traceutil/trace.go:171","msg":"trace[1807732262] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"140.399035ms","start":"2026-07-29T22:41:05.599513Z","end":"2026-07-29T22:41:05.739912Z","steps":["trace[1807732262] 'process raft request'  (duration: 126.643129ms)","trace[1807732262] 'compare'  (duration: 13.52535ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:21.914331Z","caller":"traceutil/trace.go:171","msg":"trace[2103282671] transaction","detail":"{read_only:false; response_revision:25284; number_of_response:1; }","duration":"261.507551ms","start":"2026-07-29T22:41:21.652792Z","end":"2026-07-29T22:41:21.914299Z","steps":["trace[2103282671] 'process raft request'  (duration: 261.313015ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:22.189973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.409154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763481 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25272 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:41:22.190069Z","caller":"traceutil/trace.go:171","msg":"trace[2121563035] transaction","detail":"{read_only:false; response_revision:25285; number_of_response:1; }","duration":"399.445446ms","start":"2026-07-29T22:41:21.790609Z","end":"2026-07-29T22:41:22.190055Z","steps":["trace[2121563035] 'process raft request'  (duration: 204.890819ms)","trace[2121563035] 'compare'  (duration: 194.113267ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:22.190111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:21.790583Z","time spent":"399.508228ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25272 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-29T22:41:22.791479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.081406ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763483 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:25273 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:41:22.791604Z","caller":"traceutil/trace.go:171","msg":"trace[154340169] transaction","detail":"{read_only:false; response_revision:25286; number_of_response:1; }","duration":"567.662991ms","start":"2026-07-29T22:41:22.223919Z","end":"2026-07-29T22:41:22.791582Z","steps":["trace[154340169] 'process raft request'  (duration: 357.38486ms)","trace[154340169] 'compare'  (duration: 209.810568ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:22.791664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.2239Z","time spent":"567.735712ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25273 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-29T22:41:23.345564Z","caller":"traceutil/trace.go:171","msg":"trace[281007836] transaction","detail":"{read_only:false; response_revision:25288; number_of_response:1; }","duration":"1.099631128s","start":"2026-07-29T22:41:22.245906Z","end":"2026-07-29T22:41:23.345537Z","steps":["trace[281007836] 'process raft request'  (duration: 1.099441474s)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.345706Z","caller":"traceutil/trace.go:171","msg":"trace[1066971736] transaction","detail":"{read_only:false; response_revision:25289; number_of_response:1; }","duration":"846.055102ms","start":"2026-07-29T22:41:22.499632Z","end":"2026-07-29T22:41:23.345687Z","steps":["trace[1066971736] 'process raft request'  (duration: 845.863567ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.34577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.245877Z","time spent":"1.099764052s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25275 > 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-07-29T22:41:23.34586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.499605Z","time spent":"846.193206ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25276 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-29T22:41:23.345963Z","caller":"traceutil/trace.go:171","msg":"trace[1403921990] transaction","detail":"{read_only:false; response_revision:25287; number_of_response:1; }","duration":"1.119281208s","start":"2026-07-29T22:41:22.226593Z","end":"2026-07-29T22:41:23.345875Z","steps":["trace[1403921990] 'process raft request'  (duration: 1.09848525s)","trace[1403921990] 'compare'  (duration: 19.878015ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:23.346071Z","caller":"traceutil/trace.go:171","msg":"trace[2063398367] transaction","detail":"{read_only:false; response_revision:25290; number_of_response:1; }","duration":"846.243997ms","start":"2026-07-29T22:41:22.499814Z","end":"2026-07-29T22:41:23.346058Z","steps":["trace[2063398367] 'process raft request'  (duration: 845.820136ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.346139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.49978Z","time spent":"846.327699ms","remote":"127.0.0.1:42504","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:25277 > 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-07-29T22:41:23.346137Z","caller":"traceutil/trace.go:171","msg":"trace[263178301] linearizableReadLoop","detail":"{readStateIndex:26115; appliedIndex:26112; }","duration":"928.32573ms","start":"2026-07-29T22:41:22.417798Z","end":"2026-07-29T22:41:23.346124Z","steps":["trace[263178301] 'read index received'  (duration: 163.519621ms)","trace[263178301] 'applied index is now lower than readState.Index'  (duration: 764.805359ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:23.346243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.431693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:41:23.34629Z","caller":"traceutil/trace.go:171","msg":"trace[2009170070] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:25291; }","duration":"928.515034ms","start":"2026-07-29T22:41:22.417763Z","end":"2026-07-29T22:41:23.346278Z","steps":["trace[2009170070] 'agreement among raft nodes before linearized reading'  (duration: 928.399951ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.346327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.417748Z","time spent":"928.570646ms","remote":"127.0.0.1:44262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:41:23.346377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.226575Z","time spent":"1.119497644s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25274 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-07-29T22:41:23.346352Z","caller":"traceutil/trace.go:171","msg":"trace[983230488] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"844.959536ms","start":"2026-07-29T22:41:22.501317Z","end":"2026-07-29T22:41:23.346276Z","steps":["trace[983230488] 'process raft request'  (duration: 844.69186ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.346642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.501288Z","time spent":"845.214712ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25278 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-29T22:41:23.35427Z","caller":"traceutil/trace.go:171","msg":"trace[996060998] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"336.734756ms","start":"2026-07-29T22:41:23.017505Z","end":"2026-07-29T22:41:23.35424Z","steps":["trace[996060998] 'process raft request'  (duration: 336.483099ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.354451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:23.01748Z","time spent":"336.88076ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25283 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-07-29T22:41:23.354524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.699181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:41:23.354587Z","caller":"traceutil/trace.go:171","msg":"trace[723169460] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25293; }","duration":"833.818373ms","start":"2026-07-29T22:41:22.520752Z","end":"2026-07-29T22:41:23.354571Z","steps":["trace[723169460] 'agreement among raft nodes before linearized reading'  (duration: 833.627629ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.354628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.520734Z","time spent":"833.884975ms","remote":"127.0.0.1:46510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:41:23.35466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.161175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-29T22:41:23.354715Z","caller":"traceutil/trace.go:171","msg":"trace[513835533] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:25293; }","duration":"380.245077ms","start":"2026-07-29T22:41:22.974458Z","end":"2026-07-29T22:41:23.354703Z","steps":["trace[513835533] 'agreement among raft nodes before linearized reading'  (duration: 380.137365ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.354752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.974444Z","time spent":"380.299368ms","remote":"127.0.0.1:42334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":19,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:41:23.354795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.331032ms","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-07-29T22:41:23.354819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.869814ms","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-07-29T22:41:23.354849Z","caller":"traceutil/trace.go:171","msg":"trace[1835134679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25293; }","duration":"467.409234ms","start":"2026-07-29T22:41:22.887425Z","end":"2026-07-29T22:41:23.354834Z","steps":["trace[1835134679] 'agreement among raft nodes before linearized reading'  (duration: 467.26914ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.354872Z","caller":"traceutil/trace.go:171","msg":"trace[380014226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25293; }","duration":"787.961175ms","start":"2026-07-29T22:41:22.566899Z","end":"2026-07-29T22:41:23.35486Z","steps":["trace[380014226] 'agreement among raft nodes before linearized reading'  (duration: 787.770651ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.35489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.887408Z","time spent":"467.470596ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-29T22:41:23.354904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.566887Z","time spent":"788.011286ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-29T22:41:23.354901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.889017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-29T22:41:23.354937Z","caller":"traceutil/trace.go:171","msg":"trace[1045784752] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:25293; }","duration":"797.973639ms","start":"2026-07-29T22:41:22.556952Z","end":"2026-07-29T22:41:23.354926Z","steps":["trace[1045784752] 'agreement among raft nodes before linearized reading'  (duration: 797.880837ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.354974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.346253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:41:23.355021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.999291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-29T22:41:23.355021Z","caller":"traceutil/trace.go:171","msg":"trace[1690657135] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:25293; }","duration":"110.405894ms","start":"2026-07-29T22:41:23.244602Z","end":"2026-07-29T22:41:23.355008Z","steps":["trace[1690657135] 'agreement among raft nodes before linearized reading'  (duration: 110.336742ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.355044Z","caller":"traceutil/trace.go:171","msg":"trace[885952293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25293; }","duration":"787.064693ms","start":"2026-07-29T22:41:22.567973Z","end":"2026-07-29T22:41:23.355038Z","steps":["trace[885952293] 'agreement among raft nodes before linearized reading'  (duration: 787.004321ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.355065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.567952Z","time spent":"787.110214ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-29T22:41:23.355049Z","caller":"traceutil/trace.go:171","msg":"trace[1031234451] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"178.942156ms","start":"2026-07-29T22:41:23.17608Z","end":"2026-07-29T22:41:23.355022Z","steps":["trace[1031234451] 'process raft request'  (duration: 178.065314ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.354658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.463956ms","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-07-29T22:41:23.355176Z","caller":"traceutil/trace.go:171","msg":"trace[1007029208] 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:25293; }","duration":"650.025739ms","start":"2026-07-29T22:41:22.705123Z","end":"2026-07-29T22:41:23.355149Z","steps":["trace[1007029208] 'agreement among raft nodes before linearized reading'  (duration: 649.479686ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.3552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.632828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:41:23.35522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.271228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10850"}
{"level":"warn","ts":"2026-07-29T22:41:23.355225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.464938ms","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-07-29T22:41:23.355262Z","caller":"traceutil/trace.go:171","msg":"trace[2077182289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25293; }","duration":"187.740071ms","start":"2026-07-29T22:41:23.167509Z","end":"2026-07-29T22:41:23.355249Z","steps":["trace[2077182289] 'agreement among raft nodes before linearized reading'  (duration: 187.661879ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.355282Z","caller":"traceutil/trace.go:171","msg":"trace[215918457] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25293; }","duration":"116.36267ms","start":"2026-07-29T22:41:23.238909Z","end":"2026-07-29T22:41:23.355272Z","steps":["trace[215918457] 'agreement among raft nodes before linearized reading'  (duration: 116.234807ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.355299Z","caller":"traceutil/trace.go:171","msg":"trace[1145036273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25293; }","duration":"586.657963ms","start":"2026-07-29T22:41:22.768623Z","end":"2026-07-29T22:41:23.355281Z","steps":["trace[1145036273] 'agreement among raft nodes before linearized reading'  (duration: 586.449638ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.355297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.705102Z","time spent":"650.132171ms","remote":"127.0.0.1:43156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-07-29T22:41:23.35498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.556942Z","time spent":"798.02791ms","remote":"127.0.0.1:53524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":2,"response size":30,"request content":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:41:23.355333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:22.768601Z","time spent":"586.725175ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-07-29T22:41:23.646588Z","caller":"traceutil/trace.go:171","msg":"trace[883941280] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"286.529261ms","start":"2026-07-29T22:41:23.360019Z","end":"2026-07-29T22:41:23.646549Z","steps":["trace[883941280] 'process raft request'  (duration: 222.16947ms)","trace[883941280] 'compare'  (duration: 64.192517ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:23.651736Z","caller":"traceutil/trace.go:171","msg":"trace[1191608298] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"291.543722ms","start":"2026-07-29T22:41:23.360157Z","end":"2026-07-29T22:41:23.651701Z","steps":["trace[1191608298] 'process raft request'  (duration: 291.271886ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.651788Z","caller":"traceutil/trace.go:171","msg":"trace[581821277] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"291.091022ms","start":"2026-07-29T22:41:23.360658Z","end":"2026-07-29T22:41:23.651749Z","steps":["trace[581821277] 'process raft request'  (duration: 290.933928ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:23.651851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.345485ms","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-07-29T22:41:23.651748Z","caller":"traceutil/trace.go:171","msg":"trace[1727736004] linearizableReadLoop","detail":"{readStateIndex:26124; appliedIndex:26120; }","duration":"288.237582ms","start":"2026-07-29T22:41:23.363492Z","end":"2026-07-29T22:41:23.651729Z","steps":["trace[1727736004] 'read index received'  (duration: 218.712976ms)","trace[1727736004] 'applied index is now lower than readState.Index'  (duration: 69.523566ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:23.651901Z","caller":"traceutil/trace.go:171","msg":"trace[1465655779] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25298; }","duration":"288.415717ms","start":"2026-07-29T22:41:23.363476Z","end":"2026-07-29T22:41:23.651891Z","steps":["trace[1465655779] 'agreement among raft nodes before linearized reading'  (duration: 288.316295ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.651885Z","caller":"traceutil/trace.go:171","msg":"trace[1305893655] transaction","detail":"{read_only:false; response_revision:25297; number_of_response:1; }","duration":"290.9724ms","start":"2026-07-29T22:41:23.360857Z","end":"2026-07-29T22:41:23.651829Z","steps":["trace[1305893655] 'process raft request'  (duration: 290.775415ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:23.651968Z","caller":"traceutil/trace.go:171","msg":"trace[1453915844] transaction","detail":"{read_only:false; response_revision:25298; number_of_response:1; }","duration":"283.807394ms","start":"2026-07-29T22:41:23.368141Z","end":"2026-07-29T22:41:23.651949Z","steps":["trace[1453915844] 'process raft request'  (duration: 283.532878ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:37.003659Z","caller":"traceutil/trace.go:171","msg":"trace[310238120] transaction","detail":"{read_only:false; response_revision:25405; number_of_response:1; }","duration":"171.787411ms","start":"2026-07-29T22:41:36.831839Z","end":"2026-07-29T22:41:37.003626Z","steps":["trace[310238120] 'process raft request'  (duration: 171.517955ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.178031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.418518ms","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-07-29T22:41:37.178105Z","caller":"traceutil/trace.go:171","msg":"trace[1013499900] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25405; }","duration":"127.563222ms","start":"2026-07-29T22:41:37.050524Z","end":"2026-07-29T22:41:37.178087Z","steps":["trace[1013499900] 'count revisions from in-memory index tree'  (duration: 127.322307ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:37.619622Z","caller":"traceutil/trace.go:171","msg":"trace[1880910718] transaction","detail":"{read_only:false; response_revision:25406; number_of_response:1; }","duration":"221.084814ms","start":"2026-07-29T22:41:37.398509Z","end":"2026-07-29T22:41:37.619594Z","steps":["trace[1880910718] 'process raft request'  (duration: 220.91733ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.909179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.741764ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763781 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25393 > 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-07-29T22:41:37.909469Z","caller":"traceutil/trace.go:171","msg":"trace[257726574] transaction","detail":"{read_only:false; response_revision:25407; number_of_response:1; }","duration":"507.487841ms","start":"2026-07-29T22:41:37.401947Z","end":"2026-07-29T22:41:37.909435Z","steps":["trace[257726574] 'process raft request'  (duration: 391.231775ms)","trace[257726574] 'compare'  (duration: 115.14173ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:37.909539Z","caller":"traceutil/trace.go:171","msg":"trace[723286007] linearizableReadLoop","detail":"{readStateIndex:26241; appliedIndex:26236; }","duration":"197.238142ms","start":"2026-07-29T22:41:37.712283Z","end":"2026-07-29T22:41:37.909521Z","steps":["trace[723286007] 'read index received'  (duration: 80.817772ms)","trace[723286007] 'applied index is now lower than readState.Index'  (duration: 116.419289ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:37.909599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:37.401935Z","time spent":"507.590804ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25393 > 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-07-29T22:41:37.909741Z","caller":"traceutil/trace.go:171","msg":"trace[82987633] transaction","detail":"{read_only:false; response_revision:25411; number_of_response:1; }","duration":"501.590618ms","start":"2026-07-29T22:41:37.408143Z","end":"2026-07-29T22:41:37.909733Z","steps":["trace[82987633] 'process raft request'  (duration: 501.334541ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.909775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:37.408135Z","time spent":"501.623018ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25395 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-29T22:41:37.909819Z","caller":"traceutil/trace.go:171","msg":"trace[1262821855] transaction","detail":"{read_only:false; response_revision:25408; number_of_response:1; }","duration":"507.174465ms","start":"2026-07-29T22:41:37.402639Z","end":"2026-07-29T22:41:37.909814Z","steps":["trace[1262821855] 'process raft request'  (duration: 506.661432ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.909827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.54854ms","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-07-29T22:41:37.909861Z","caller":"traceutil/trace.go:171","msg":"trace[1574574310] transaction","detail":"{read_only:false; response_revision:25409; number_of_response:1; }","duration":"502.216843ms","start":"2026-07-29T22:41:37.40764Z","end":"2026-07-29T22:41:37.909857Z","steps":["trace[1574574310] 'process raft request'  (duration: 501.767862ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:37.909869Z","caller":"traceutil/trace.go:171","msg":"trace[79440101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25411; }","duration":"197.633622ms","start":"2026-07-29T22:41:37.712225Z","end":"2026-07-29T22:41:37.909859Z","steps":["trace[79440101] 'agreement among raft nodes before linearized reading'  (duration: 197.56305ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.909884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:37.407617Z","time spent":"502.256884ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25397 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-29T22:41:37.909926Z","caller":"traceutil/trace.go:171","msg":"trace[365377303] transaction","detail":"{read_only:false; response_revision:25410; number_of_response:1; }","duration":"502.0913ms","start":"2026-07-29T22:41:37.407829Z","end":"2026-07-29T22:41:37.90992Z","steps":["trace[365377303] 'process raft request'  (duration: 501.614259ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.909951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:37.407818Z","time spent":"502.121101ms","remote":"127.0.0.1:42504","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:25396 > 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-07-29T22:41:37.910014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.083894ms","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-07-29T22:41:37.91005Z","caller":"traceutil/trace.go:171","msg":"trace[837147865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25411; }","duration":"196.171636ms","start":"2026-07-29T22:41:37.71387Z","end":"2026-07-29T22:41:37.910042Z","steps":["trace[837147865] 'agreement among raft nodes before linearized reading'  (duration: 196.110655ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:37.909841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:37.402617Z","time spent":"507.210505ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25394 > 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-07-29T22:41:37.910339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.243454ms","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-07-29T22:41:37.91038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.720371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-29T22:41:37.910437Z","caller":"traceutil/trace.go:171","msg":"trace[1210405158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25411; }","duration":"195.368427ms","start":"2026-07-29T22:41:37.715035Z","end":"2026-07-29T22:41:37.910403Z","steps":["trace[1210405158] 'agreement among raft nodes before linearized reading'  (duration: 195.11147ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:37.910495Z","caller":"traceutil/trace.go:171","msg":"trace[367561373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25411; }","duration":"194.844864ms","start":"2026-07-29T22:41:37.715623Z","end":"2026-07-29T22:41:37.910468Z","steps":["trace[367561373] 'agreement among raft nodes before linearized reading'  (duration: 194.479055ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:38.062213Z","caller":"traceutil/trace.go:171","msg":"trace[630534982] transaction","detail":"{read_only:false; response_revision:25413; number_of_response:1; }","duration":"148.36565ms","start":"2026-07-29T22:41:37.913822Z","end":"2026-07-29T22:41:38.062188Z","steps":["trace[630534982] 'process raft request'  (duration: 148.290458ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:38.06257Z","caller":"traceutil/trace.go:171","msg":"trace[50338387] transaction","detail":"{read_only:false; response_revision:25412; number_of_response:1; }","duration":"148.837102ms","start":"2026-07-29T22:41:37.913711Z","end":"2026-07-29T22:41:38.062548Z","steps":["trace[50338387] 'process raft request'  (duration: 100.870481ms)","trace[50338387] 'compare'  (duration: 47.379146ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:38.062552Z","caller":"traceutil/trace.go:171","msg":"trace[1109938326] transaction","detail":"{read_only:false; response_revision:25414; number_of_response:1; }","duration":"147.207522ms","start":"2026-07-29T22:41:37.915317Z","end":"2026-07-29T22:41:38.062525Z","steps":["trace[1109938326] 'process raft request'  (duration: 146.830503ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:38.062737Z","caller":"traceutil/trace.go:171","msg":"trace[1633327585] transaction","detail":"{read_only:false; response_revision:25415; number_of_response:1; }","duration":"147.10155ms","start":"2026-07-29T22:41:37.915615Z","end":"2026-07-29T22:41:38.062716Z","steps":["trace[1633327585] 'process raft request'  (duration: 146.764262ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:38.461072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.661693ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763794 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25402 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:41:38.461256Z","caller":"traceutil/trace.go:171","msg":"trace[1958167] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"222.108538ms","start":"2026-07-29T22:41:38.23913Z","end":"2026-07-29T22:41:38.461239Z","steps":["trace[1958167] 'process raft request'  (duration: 222.038927ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:38.461523Z","caller":"traceutil/trace.go:171","msg":"trace[1588559259] transaction","detail":"{read_only:false; response_revision:25416; number_of_response:1; }","duration":"394.482214ms","start":"2026-07-29T22:41:38.067012Z","end":"2026-07-29T22:41:38.461494Z","steps":["trace[1588559259] 'process raft request'  (duration: 139.264578ms)","trace[1588559259] 'compare'  (duration: 254.560141ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:38.461725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:38.066989Z","time spent":"394.600528ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25402 > 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-07-29T22:41:38.779651Z","caller":"traceutil/trace.go:171","msg":"trace[1824647651] transaction","detail":"{read_only:false; response_revision:25419; number_of_response:1; }","duration":"104.644322ms","start":"2026-07-29T22:41:38.674971Z","end":"2026-07-29T22:41:38.779615Z","steps":["trace[1824647651] 'process raft request'  (duration: 104.398286ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:39.094334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.555803ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763800 > lease_revoke:<id:34239fafdd677447>","response":"size:28"}
{"level":"warn","ts":"2026-07-29T22:41:39.379066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.346301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:41:39.379168Z","caller":"traceutil/trace.go:171","msg":"trace[1243598246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25420; }","duration":"212.490014ms","start":"2026-07-29T22:41:39.166657Z","end":"2026-07-29T22:41:39.379147Z","steps":["trace[1243598246] 'range keys from in-memory index tree'  (duration: 212.264338ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:40.744232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.599944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:41:40.744345Z","caller":"traceutil/trace.go:171","msg":"trace[85431697] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:25432; }","duration":"191.781578ms","start":"2026-07-29T22:41:40.552535Z","end":"2026-07-29T22:41:40.744317Z","steps":["trace[85431697] 'count revisions from in-memory index tree'  (duration: 191.474401ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:41.121165Z","caller":"traceutil/trace.go:171","msg":"trace[1921291283] transaction","detail":"{read_only:false; response_revision:25433; number_of_response:1; }","duration":"232.879832ms","start":"2026-07-29T22:41:40.888264Z","end":"2026-07-29T22:41:41.121144Z","steps":["trace[1921291283] 'process raft request'  (duration: 232.766269ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:41.404589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.967541ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763833 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:25420 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:41:41.404677Z","caller":"traceutil/trace.go:171","msg":"trace[1662164506] linearizableReadLoop","detail":"{readStateIndex:26265; appliedIndex:26264; }","duration":"239.34783ms","start":"2026-07-29T22:41:41.165318Z","end":"2026-07-29T22:41:41.404665Z","steps":["trace[1662164506] 'read index received'  (duration: 33.071µs)","trace[1662164506] 'applied index is now lower than readState.Index'  (duration: 239.314139ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:41.404694Z","caller":"traceutil/trace.go:171","msg":"trace[95912412] transaction","detail":"{read_only:false; response_revision:25434; number_of_response:1; }","duration":"304.726835ms","start":"2026-07-29T22:41:41.099948Z","end":"2026-07-29T22:41:41.404675Z","steps":["trace[95912412] 'process raft request'  (duration: 49.614431ms)","trace[95912412] 'compare'  (duration: 254.780976ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:41.404718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.402101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:41:41.404733Z","caller":"traceutil/trace.go:171","msg":"trace[1205081011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25434; }","duration":"239.450192ms","start":"2026-07-29T22:41:41.165278Z","end":"2026-07-29T22:41:41.404728Z","steps":["trace[1205081011] 'agreement among raft nodes before linearized reading'  (duration: 239.414182ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:41.404766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:41.099922Z","time spent":"304.808706ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25420 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-29T22:41:41.982739Z","caller":"traceutil/trace.go:171","msg":"trace[1924304712] transaction","detail":"{read_only:false; response_revision:25436; number_of_response:1; }","duration":"118.819018ms","start":"2026-07-29T22:41:41.863891Z","end":"2026-07-29T22:41:41.98271Z","steps":["trace[1924304712] 'process raft request'  (duration: 118.633894ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.252146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.670983ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839763839 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25425 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:41:42.252336Z","caller":"traceutil/trace.go:171","msg":"trace[2131366427] transaction","detail":"{read_only:false; response_revision:25437; number_of_response:1; }","duration":"329.229573ms","start":"2026-07-29T22:41:41.923081Z","end":"2026-07-29T22:41:42.25231Z","steps":["trace[2131366427] 'process raft request'  (duration: 167.293542ms)","trace[2131366427] 'compare'  (duration: 161.405417ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:42.252425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:41.923044Z","time spent":"329.336356ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25425 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-29T22:41:42.25273Z","caller":"traceutil/trace.go:171","msg":"trace[418182719] linearizableReadLoop","detail":"{readStateIndex:26272; appliedIndex:26267; }","duration":"214.628606ms","start":"2026-07-29T22:41:42.038076Z","end":"2026-07-29T22:41:42.252705Z","steps":["trace[418182719] 'read index received'  (duration: 52.321046ms)","trace[418182719] 'applied index is now lower than readState.Index'  (duration: 162.30644ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:42.252873Z","caller":"traceutil/trace.go:171","msg":"trace[80207094] transaction","detail":"{read_only:false; response_revision:25441; number_of_response:1; }","duration":"328.272819ms","start":"2026-07-29T22:41:41.924586Z","end":"2026-07-29T22:41:42.252859Z","steps":["trace[80207094] 'process raft request'  (duration: 328.070414ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.252923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.824852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-29T22:41:42.252962Z","caller":"traceutil/trace.go:171","msg":"trace[263061569] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:25441; }","duration":"214.926204ms","start":"2026-07-29T22:41:42.038024Z","end":"2026-07-29T22:41:42.25295Z","steps":["trace[263061569] 'agreement among raft nodes before linearized reading'  (duration: 214.832702ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:42.252961Z","caller":"traceutil/trace.go:171","msg":"trace[1194676882] transaction","detail":"{read_only:false; response_revision:25439; number_of_response:1; }","duration":"329.53385ms","start":"2026-07-29T22:41:41.923402Z","end":"2026-07-29T22:41:42.252935Z","steps":["trace[1194676882] 'process raft request'  (duration: 329.057638ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.253055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:41.924574Z","time spent":"328.3285ms","remote":"127.0.0.1:42504","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:25426 > 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-07-29T22:41:42.253111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:41.923389Z","time spent":"329.637913ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25422 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-29T22:41:42.253234Z","caller":"traceutil/trace.go:171","msg":"trace[828433172] transaction","detail":"{read_only:false; response_revision:25440; number_of_response:1; }","duration":"328.725901ms","start":"2026-07-29T22:41:41.924495Z","end":"2026-07-29T22:41:42.253221Z","steps":["trace[828433172] 'process raft request'  (duration: 328.091246ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.253276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.756959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-07-29T22:41:42.253294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:41.924484Z","time spent":"328.777422ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25424 > 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-07-29T22:41:42.2533Z","caller":"traceutil/trace.go:171","msg":"trace[2064851125] transaction","detail":"{read_only:false; response_revision:25438; number_of_response:1; }","duration":"330.037122ms","start":"2026-07-29T22:41:41.923251Z","end":"2026-07-29T22:41:42.253288Z","steps":["trace[2064851125] 'process raft request'  (duration: 328.992436ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:42.253316Z","caller":"traceutil/trace.go:171","msg":"trace[1682645479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25441; }","duration":"175.81715ms","start":"2026-07-29T22:41:42.077489Z","end":"2026-07-29T22:41:42.253306Z","steps":["trace[1682645479] 'agreement among raft nodes before linearized reading'  (duration: 175.696547ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.25336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:41:41.923202Z","time spent":"330.125634ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25423 > 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-07-29T22:41:42.253587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.976189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-29T22:41:42.253625Z","caller":"traceutil/trace.go:171","msg":"trace[578087076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25441; }","duration":"175.020921ms","start":"2026-07-29T22:41:42.078591Z","end":"2026-07-29T22:41:42.253612Z","steps":["trace[578087076] 'agreement among raft nodes before linearized reading'  (duration: 174.887688ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.253672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.241606ms","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-07-29T22:41:42.253709Z","caller":"traceutil/trace.go:171","msg":"trace[1934714166] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25441; }","duration":"175.302577ms","start":"2026-07-29T22:41:42.078393Z","end":"2026-07-29T22:41:42.253696Z","steps":["trace[1934714166] 'agreement among raft nodes before linearized reading'  (duration: 175.205535ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:42.253779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.137403ms","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-07-29T22:41:42.253837Z","caller":"traceutil/trace.go:171","msg":"trace[996272147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25441; }","duration":"175.204294ms","start":"2026-07-29T22:41:42.078621Z","end":"2026-07-29T22:41:42.253825Z","steps":["trace[996272147] 'agreement among raft nodes before linearized reading'  (duration: 175.090972ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:42.366382Z","caller":"traceutil/trace.go:171","msg":"trace[814079108] transaction","detail":"{read_only:false; response_revision:25444; number_of_response:1; }","duration":"105.826863ms","start":"2026-07-29T22:41:42.260524Z","end":"2026-07-29T22:41:42.366351Z","steps":["trace[814079108] 'process raft request'  (duration: 105.70544ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:42.366496Z","caller":"traceutil/trace.go:171","msg":"trace[1258726815] transaction","detail":"{read_only:false; response_revision:25445; number_of_response:1; }","duration":"105.407341ms","start":"2026-07-29T22:41:42.261057Z","end":"2026-07-29T22:41:42.366464Z","steps":["trace[1258726815] 'process raft request'  (duration: 105.246317ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:42.366696Z","caller":"traceutil/trace.go:171","msg":"trace[1049787930] transaction","detail":"{read_only:false; response_revision:25443; number_of_response:1; }","duration":"107.894212ms","start":"2026-07-29T22:41:42.258789Z","end":"2026-07-29T22:41:42.366683Z","steps":["trace[1049787930] 'process raft request'  (duration: 106.929728ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:44.092894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.468738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-29T22:41:44.092993Z","caller":"traceutil/trace.go:171","msg":"trace[466562914] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:25451; }","duration":"188.566131ms","start":"2026-07-29T22:41:43.90439Z","end":"2026-07-29T22:41:44.092956Z","steps":["trace[466562914] 'count revisions from in-memory index tree'  (duration: 188.377167ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:46.495855Z","caller":"traceutil/trace.go:171","msg":"trace[1390676931] transaction","detail":"{read_only:false; response_revision:25467; number_of_response:1; }","duration":"163.180071ms","start":"2026-07-29T22:41:46.332649Z","end":"2026-07-29T22:41:46.495829Z","steps":["trace[1390676931] 'process raft request'  (duration: 106.055337ms)","trace[1390676931] 'compare'  (duration: 56.871818ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:46.495873Z","caller":"traceutil/trace.go:171","msg":"trace[1958335545] transaction","detail":"{read_only:false; response_revision:25468; number_of_response:1; }","duration":"162.29981ms","start":"2026-07-29T22:41:46.333545Z","end":"2026-07-29T22:41:46.495845Z","steps":["trace[1958335545] 'process raft request'  (duration: 162.194298ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:46.495988Z","caller":"traceutil/trace.go:171","msg":"trace[1117025859] transaction","detail":"{read_only:false; response_revision:25469; number_of_response:1; }","duration":"162.394742ms","start":"2026-07-29T22:41:46.333571Z","end":"2026-07-29T22:41:46.495966Z","steps":["trace[1117025859] 'process raft request'  (duration: 162.242808ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:46.496216Z","caller":"traceutil/trace.go:171","msg":"trace[629268163] transaction","detail":"{read_only:false; response_revision:25470; number_of_response:1; }","duration":"161.465119ms","start":"2026-07-29T22:41:46.334738Z","end":"2026-07-29T22:41:46.496203Z","steps":["trace[629268163] 'process raft request'  (duration: 161.174092ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:46.496121Z","caller":"traceutil/trace.go:171","msg":"trace[2092261895] linearizableReadLoop","detail":"{readStateIndex:26302; appliedIndex:26297; }","duration":"132.519653ms","start":"2026-07-29T22:41:46.363571Z","end":"2026-07-29T22:41:46.49609Z","steps":["trace[2092261895] 'read index received'  (duration: 37.376452ms)","trace[2092261895] 'applied index is now lower than readState.Index'  (duration: 95.141991ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:46.496396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.820671ms","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-07-29T22:41:46.496461Z","caller":"traceutil/trace.go:171","msg":"trace[1492669198] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25470; }","duration":"132.946355ms","start":"2026-07-29T22:41:46.363497Z","end":"2026-07-29T22:41:46.496444Z","steps":["trace[1492669198] 'agreement among raft nodes before linearized reading'  (duration: 132.683667ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:46.517924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.659981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-29T22:41:46.517925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.592929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:41:46.51799Z","caller":"traceutil/trace.go:171","msg":"trace[1615612033] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:25471; }","duration":"140.781664ms","start":"2026-07-29T22:41:46.377194Z","end":"2026-07-29T22:41:46.517976Z","steps":["trace[1615612033] 'agreement among raft nodes before linearized reading'  (duration: 140.574789ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:46.518007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.481979ms","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-07-29T22:41:46.518013Z","caller":"traceutil/trace.go:171","msg":"trace[1946215530] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:25471; }","duration":"124.729473ms","start":"2026-07-29T22:41:46.393261Z","end":"2026-07-29T22:41:46.517991Z","steps":["trace[1946215530] 'agreement among raft nodes before linearized reading'  (duration: 124.574529ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:46.518044Z","caller":"traceutil/trace.go:171","msg":"trace[164458626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25471; }","duration":"138.563351ms","start":"2026-07-29T22:41:46.379471Z","end":"2026-07-29T22:41:46.518034Z","steps":["trace[164458626] 'agreement among raft nodes before linearized reading'  (duration: 138.426607ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:46.518135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.686873ms","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-07-29T22:41:46.518217Z","caller":"traceutil/trace.go:171","msg":"trace[1803641530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25471; }","duration":"138.796096ms","start":"2026-07-29T22:41:46.379407Z","end":"2026-07-29T22:41:46.518203Z","steps":["trace[1803641530] 'agreement among raft nodes before linearized reading'  (duration: 138.602461ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:46.518215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.10908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-29T22:41:46.518327Z","caller":"traceutil/trace.go:171","msg":"trace[31165575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25471; }","duration":"138.297223ms","start":"2026-07-29T22:41:46.380015Z","end":"2026-07-29T22:41:46.518312Z","steps":["trace[31165575] 'agreement among raft nodes before linearized reading'  (duration: 137.964805ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:58.7314Z","caller":"traceutil/trace.go:171","msg":"trace[628189443] linearizableReadLoop","detail":"{readStateIndex:26395; appliedIndex:26394; }","duration":"109.04457ms","start":"2026-07-29T22:41:58.622333Z","end":"2026-07-29T22:41:58.731377Z","steps":["trace[628189443] 'read index received'  (duration: 108.871176ms)","trace[628189443] 'applied index is now lower than readState.Index'  (duration: 172.484µs)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:41:58.73153Z","caller":"traceutil/trace.go:171","msg":"trace[232099479] transaction","detail":"{read_only:false; response_revision:25561; number_of_response:1; }","duration":"116.160784ms","start":"2026-07-29T22:41:58.61533Z","end":"2026-07-29T22:41:58.731491Z","steps":["trace[232099479] 'process raft request'  (duration: 115.891277ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:58.731632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.783788ms","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-07-29T22:41:58.731673Z","caller":"traceutil/trace.go:171","msg":"trace[1643525724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25561; }","duration":"102.882951ms","start":"2026-07-29T22:41:58.628779Z","end":"2026-07-29T22:41:58.731662Z","steps":["trace[1643525724] 'agreement among raft nodes before linearized reading'  (duration: 102.741747ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:58.731759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.4152ms","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-07-29T22:41:58.731813Z","caller":"traceutil/trace.go:171","msg":"trace[1823716417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25561; }","duration":"100.490502ms","start":"2026-07-29T22:41:58.631309Z","end":"2026-07-29T22:41:58.7318Z","steps":["trace[1823716417] 'agreement among raft nodes before linearized reading'  (duration: 100.361739ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:58.731913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.741748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-07-29T22:41:58.731975Z","caller":"traceutil/trace.go:171","msg":"trace[1481246793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25561; }","duration":"100.855181ms","start":"2026-07-29T22:41:58.631106Z","end":"2026-07-29T22:41:58.731961Z","steps":["trace[1481246793] 'agreement among raft nodes before linearized reading'  (duration: 100.619945ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:41:58.731943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.584714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-29T22:41:58.732156Z","caller":"traceutil/trace.go:171","msg":"trace[1836114063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25561; }","duration":"109.778138ms","start":"2026-07-29T22:41:58.622308Z","end":"2026-07-29T22:41:58.732086Z","steps":["trace[1836114063] 'agreement among raft nodes before linearized reading'  (duration: 109.199384ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:58.88156Z","caller":"traceutil/trace.go:171","msg":"trace[1743826013] transaction","detail":"{read_only:false; response_revision:25564; number_of_response:1; }","duration":"144.428694ms","start":"2026-07-29T22:41:58.737105Z","end":"2026-07-29T22:41:58.881533Z","steps":["trace[1743826013] 'process raft request'  (duration: 144.338462ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:58.881561Z","caller":"traceutil/trace.go:171","msg":"trace[277597102] transaction","detail":"{read_only:false; response_revision:25563; number_of_response:1; }","duration":"144.347172ms","start":"2026-07-29T22:41:58.737187Z","end":"2026-07-29T22:41:58.881534Z","steps":["trace[277597102] 'process raft request'  (duration: 144.037874ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:58.881741Z","caller":"traceutil/trace.go:171","msg":"trace[1287567892] linearizableReadLoop","detail":"{readStateIndex:26399; appliedIndex:26395; }","duration":"142.22623ms","start":"2026-07-29T22:41:58.739484Z","end":"2026-07-29T22:41:58.88171Z","steps":["trace[1287567892] 'read index received'  (duration: 14.797881ms)","trace[1287567892] 'applied index is now lower than readState.Index'  (duration: 127.425779ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:41:58.881986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.473826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-07-29T22:41:58.881941Z","caller":"traceutil/trace.go:171","msg":"trace[1695749739] transaction","detail":"{read_only:false; response_revision:25565; number_of_response:1; }","duration":"143.920642ms","start":"2026-07-29T22:41:58.737942Z","end":"2026-07-29T22:41:58.881863Z","steps":["trace[1695749739] 'process raft request'  (duration: 143.553503ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:41:58.882018Z","caller":"traceutil/trace.go:171","msg":"trace[1401678956] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:25565; }","duration":"142.550608ms","start":"2026-07-29T22:41:58.739457Z","end":"2026-07-29T22:41:58.882008Z","steps":["trace[1401678956] 'agreement among raft nodes before linearized reading'  (duration: 142.355754ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:04.708785Z","caller":"traceutil/trace.go:171","msg":"trace[899212089] transaction","detail":"{read_only:false; response_revision:25598; number_of_response:1; }","duration":"149.465497ms","start":"2026-07-29T22:42:04.559278Z","end":"2026-07-29T22:42:04.708744Z","steps":["trace[899212089] 'process raft request'  (duration: 82.79816ms)","trace[899212089] 'compare'  (duration: 66.522334ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:04.806311Z","caller":"traceutil/trace.go:171","msg":"trace[991162806] transaction","detail":"{read_only:false; response_revision:25599; number_of_response:1; }","duration":"246.3359ms","start":"2026-07-29T22:42:04.559941Z","end":"2026-07-29T22:42:04.806277Z","steps":["trace[991162806] 'process raft request'  (duration: 246.034402ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:04.80652Z","caller":"traceutil/trace.go:171","msg":"trace[55290629] transaction","detail":"{read_only:false; response_revision:25600; number_of_response:1; }","duration":"244.133777ms","start":"2026-07-29T22:42:04.562349Z","end":"2026-07-29T22:42:04.806483Z","steps":["trace[55290629] 'process raft request'  (duration: 243.85807ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:04.806646Z","caller":"traceutil/trace.go:171","msg":"trace[659731340] transaction","detail":"{read_only:false; response_revision:25601; number_of_response:1; }","duration":"242.022815ms","start":"2026-07-29T22:42:04.564598Z","end":"2026-07-29T22:42:04.806621Z","steps":["trace[659731340] 'process raft request'  (duration: 241.854731ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:04.806785Z","caller":"traceutil/trace.go:171","msg":"trace[1333495957] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"238.893089ms","start":"2026-07-29T22:42:04.567879Z","end":"2026-07-29T22:42:04.806772Z","steps":["trace[1333495957] 'process raft request'  (duration: 238.684654ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:05.082424Z","caller":"traceutil/trace.go:171","msg":"trace[249097101] linearizableReadLoop","detail":"{readStateIndex:26441; appliedIndex:26440; }","duration":"173.295408ms","start":"2026-07-29T22:42:04.909086Z","end":"2026-07-29T22:42:05.082381Z","steps":["trace[249097101] 'read index received'  (duration: 96.373171ms)","trace[249097101] 'applied index is now lower than readState.Index'  (duration: 76.919847ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:05.082481Z","caller":"traceutil/trace.go:171","msg":"trace[1879945906] transaction","detail":"{read_only:false; response_revision:25605; number_of_response:1; }","duration":"173.503273ms","start":"2026-07-29T22:42:04.908939Z","end":"2026-07-29T22:42:05.082443Z","steps":["trace[1879945906] 'process raft request'  (duration: 96.495635ms)","trace[1879945906] 'compare'  (duration: 76.576808ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:42:05.082769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.650146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-29T22:42:05.082865Z","caller":"traceutil/trace.go:171","msg":"trace[951491767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25605; }","duration":"173.77861ms","start":"2026-07-29T22:42:04.909065Z","end":"2026-07-29T22:42:05.082843Z","steps":["trace[951491767] 'agreement among raft nodes before linearized reading'  (duration: 173.487373ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:05.386393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.00035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839764233 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25590 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:42:05.386578Z","caller":"traceutil/trace.go:171","msg":"trace[1382459218] transaction","detail":"{read_only:false; response_revision:25606; number_of_response:1; }","duration":"473.118073ms","start":"2026-07-29T22:42:04.913415Z","end":"2026-07-29T22:42:05.386533Z","steps":["trace[1382459218] 'process raft request'  (duration: 272.915768ms)","trace[1382459218] 'compare'  (duration: 199.919138ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:05.386647Z","caller":"traceutil/trace.go:171","msg":"trace[1545524379] linearizableReadLoop","detail":"{readStateIndex:26442; appliedIndex:26441; }","duration":"304.11717ms","start":"2026-07-29T22:42:05.082518Z","end":"2026-07-29T22:42:05.386635Z","steps":["trace[1545524379] 'read index received'  (duration: 103.987927ms)","trace[1545524379] 'applied index is now lower than readState.Index'  (duration: 200.128653ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:42:05.386708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.498852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:42:05.386722Z","caller":"traceutil/trace.go:171","msg":"trace[275986310] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25608; }","duration":"425.568873ms","start":"2026-07-29T22:42:04.961147Z","end":"2026-07-29T22:42:05.386716Z","steps":["trace[275986310] 'agreement among raft nodes before linearized reading'  (duration: 425.519082ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:05.386736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:04.961124Z","time spent":"425.608235ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-07-29T22:42:05.386755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:04.913392Z","time spent":"473.265307ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25590 > 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-07-29T22:42:05.386782Z","caller":"traceutil/trace.go:171","msg":"trace[63290316] transaction","detail":"{read_only:false; response_revision:25607; number_of_response:1; }","duration":"298.427412ms","start":"2026-07-29T22:42:05.088299Z","end":"2026-07-29T22:42:05.386726Z","steps":["trace[63290316] 'process raft request'  (duration: 298.174015ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:13.081586Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067ce.wal"}
{"level":"info","ts":"2026-07-29T22:42:16.759705Z","caller":"traceutil/trace.go:171","msg":"trace[1516600690] linearizableReadLoop","detail":"{readStateIndex:26669; appliedIndex:26668; }","duration":"154.594732ms","start":"2026-07-29T22:42:16.605091Z","end":"2026-07-29T22:42:16.759685Z","steps":["trace[1516600690] 'read index received'  (duration: 154.54326ms)","trace[1516600690] 'applied index is now lower than readState.Index'  (duration: 50.582µs)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:16.759812Z","caller":"traceutil/trace.go:171","msg":"trace[1862731087] transaction","detail":"{read_only:false; response_revision:25829; number_of_response:1; }","duration":"210.272901ms","start":"2026-07-29T22:42:16.549492Z","end":"2026-07-29T22:42:16.759765Z","steps":["trace[1862731087] 'process raft request'  (duration: 210.073906ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:16.759931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.803977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:42:16.760047Z","caller":"traceutil/trace.go:171","msg":"trace[1089127124] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25829; }","duration":"154.999412ms","start":"2026-07-29T22:42:16.605018Z","end":"2026-07-29T22:42:16.760017Z","steps":["trace[1089127124] 'agreement among raft nodes before linearized reading'  (duration: 154.781217ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:17.044014Z","caller":"traceutil/trace.go:171","msg":"trace[2100084370] transaction","detail":"{read_only:false; response_revision:25835; number_of_response:1; }","duration":"134.213244ms","start":"2026-07-29T22:42:16.909775Z","end":"2026-07-29T22:42:17.043988Z","steps":["trace[2100084370] 'process raft request'  (duration: 134.086541ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:17.044237Z","caller":"traceutil/trace.go:171","msg":"trace[618977601] linearizableReadLoop","detail":"{readStateIndex:26675; appliedIndex:26675; }","duration":"102.609764ms","start":"2026-07-29T22:42:16.941616Z","end":"2026-07-29T22:42:17.044225Z","steps":["trace[618977601] 'read index received'  (duration: 102.604254ms)","trace[618977601] 'applied index is now lower than readState.Index'  (duration: 4.62µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:42:17.044476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.85449ms","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-07-29T22:42:17.044519Z","caller":"traceutil/trace.go:171","msg":"trace[1809242556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25835; }","duration":"102.950412ms","start":"2026-07-29T22:42:16.941555Z","end":"2026-07-29T22:42:17.044506Z","steps":["trace[1809242556] 'agreement among raft nodes before linearized reading'  (duration: 102.803818ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.045023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.108381ms","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-07-29T22:42:17.045088Z","caller":"traceutil/trace.go:171","msg":"trace[670700771] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25835; }","duration":"102.223054ms","start":"2026-07-29T22:42:16.942851Z","end":"2026-07-29T22:42:17.045074Z","steps":["trace[670700771] 'agreement among raft nodes before linearized reading'  (duration: 102.043429ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:17.307662Z","caller":"traceutil/trace.go:171","msg":"trace[1676396198] transaction","detail":"{read_only:false; response_revision:25836; number_of_response:1; }","duration":"259.032999ms","start":"2026-07-29T22:42:17.048603Z","end":"2026-07-29T22:42:17.307636Z","steps":["trace[1676396198] 'process raft request'  (duration: 258.839784ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:17.514366Z","caller":"traceutil/trace.go:171","msg":"trace[83133903] transaction","detail":"{read_only:false; response_revision:25838; number_of_response:1; }","duration":"465.263932ms","start":"2026-07-29T22:42:17.049056Z","end":"2026-07-29T22:42:17.51432Z","steps":["trace[83133903] 'process raft request'  (duration: 464.878032ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.514494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.049046Z","time spent":"465.376474ms","remote":"127.0.0.1:42518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1051,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/magnum-registry-4dc48\" mod_revision:24720 > success:<request_put:<key:\"/registry/endpointslices/openstack/magnum-registry-4dc48\" value_size:987 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/magnum-registry-4dc48\" > >"}
{"level":"info","ts":"2026-07-29T22:42:17.514472Z","caller":"traceutil/trace.go:171","msg":"trace[660776737] transaction","detail":"{read_only:false; response_revision:25839; number_of_response:1; }","duration":"464.002491ms","start":"2026-07-29T22:42:17.050439Z","end":"2026-07-29T22:42:17.514441Z","steps":["trace[660776737] 'process raft request'  (duration: 463.803656ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.514786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.050421Z","time spent":"464.179525ms","remote":"127.0.0.1:42394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":676,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/magnum-registry\" mod_revision:24721 > success:<request_put:<key:\"/registry/services/endpoints/openstack/magnum-registry\" value_size:614 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/magnum-registry\" > >"}
{"level":"info","ts":"2026-07-29T22:42:17.514785Z","caller":"traceutil/trace.go:171","msg":"trace[1739638734] transaction","detail":"{read_only:false; response_revision:25840; number_of_response:1; }","duration":"364.861982ms","start":"2026-07-29T22:42:17.14989Z","end":"2026-07-29T22:42:17.514752Z","steps":["trace[1739638734] 'process raft request'  (duration: 364.473813ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:17.514125Z","caller":"traceutil/trace.go:171","msg":"trace[1867368443] transaction","detail":"{read_only:false; response_revision:25837; number_of_response:1; }","duration":"465.373284ms","start":"2026-07-29T22:42:17.048677Z","end":"2026-07-29T22:42:17.514051Z","steps":["trace[1867368443] 'process raft request'  (duration: 455.490142ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.515271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.149855Z","time spent":"365.338704ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:25619 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-07-29T22:42:17.5153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.048645Z","time spent":"466.590803ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25819 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-07-29T22:42:17.515381Z","caller":"traceutil/trace.go:171","msg":"trace[2044169803] linearizableReadLoop","detail":"{readStateIndex:26679; appliedIndex:26675; }","duration":"446.319359ms","start":"2026-07-29T22:42:17.069047Z","end":"2026-07-29T22:42:17.515366Z","steps":["trace[2044169803] 'read index received'  (duration: 238.468168ms)","trace[2044169803] 'applied index is now lower than readState.Index'  (duration: 207.850171ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:17.515518Z","caller":"traceutil/trace.go:171","msg":"trace[570442658] transaction","detail":"{read_only:false; response_revision:25841; number_of_response:1; }","duration":"264.068352ms","start":"2026-07-29T22:42:17.25144Z","end":"2026-07-29T22:42:17.515508Z","steps":["trace[570442658] 'process raft request'  (duration: 263.317244ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.515737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.685958ms","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-07-29T22:42:17.515783Z","caller":"traceutil/trace.go:171","msg":"trace[833223372] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:25841; }","duration":"446.759759ms","start":"2026-07-29T22:42:17.069011Z","end":"2026-07-29T22:42:17.51577Z","steps":["trace[833223372] 'agreement among raft nodes before linearized reading'  (duration: 446.547834ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.515981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.068995Z","time spent":"446.977104ms","remote":"127.0.0.1:42812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:42:17.51595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.704304ms","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:8"}
{"level":"info","ts":"2026-07-29T22:42:17.517076Z","caller":"traceutil/trace.go:171","msg":"trace[592926140] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:25841; }","duration":"312.871883ms","start":"2026-07-29T22:42:17.204181Z","end":"2026-07-29T22:42:17.517053Z","steps":["trace[592926140] 'agreement among raft nodes before linearized reading'  (duration: 311.678024ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.517136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.204159Z","time spent":"312.947155ms","remote":"127.0.0.1:58256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-07-29T22:42:17.516183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.113588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:42:17.517261Z","caller":"traceutil/trace.go:171","msg":"trace[1367567254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25841; }","duration":"350.250106ms","start":"2026-07-29T22:42:17.16699Z","end":"2026-07-29T22:42:17.51724Z","steps":["trace[1367567254] 'agreement among raft nodes before linearized reading'  (duration: 349.050087ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.517343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.166977Z","time spent":"350.333367ms","remote":"127.0.0.1:42224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-29T22:42:17.51622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.040738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-29T22:42:17.517422Z","caller":"traceutil/trace.go:171","msg":"trace[1103096705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25841; }","duration":"380.258327ms","start":"2026-07-29T22:42:17.137137Z","end":"2026-07-29T22:42:17.517396Z","steps":["trace[1103096705] 'agreement among raft nodes before linearized reading'  (duration: 378.688399ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:17.517531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T22:42:17.137068Z","time spent":"380.433822ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-07-29T22:42:18.073517Z","caller":"traceutil/trace.go:171","msg":"trace[179400370] transaction","detail":"{read_only:false; response_revision:25847; number_of_response:1; }","duration":"129.760845ms","start":"2026-07-29T22:42:17.94372Z","end":"2026-07-29T22:42:18.073481Z","steps":["trace[179400370] 'process raft request'  (duration: 119.298841ms)","trace[179400370] 'compare'  (duration: 10.331901ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:18.286765Z","caller":"traceutil/trace.go:171","msg":"trace[1519297345] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"207.578934ms","start":"2026-07-29T22:42:18.079151Z","end":"2026-07-29T22:42:18.28673Z","steps":["trace[1519297345] 'process raft request'  (duration: 121.039043ms)","trace[1519297345] 'compare'  (duration: 86.374517ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:18.347229Z","caller":"traceutil/trace.go:171","msg":"trace[1606567504] linearizableReadLoop","detail":"{readStateIndex:26690; appliedIndex:26687; }","duration":"245.717625ms","start":"2026-07-29T22:42:18.101483Z","end":"2026-07-29T22:42:18.347201Z","steps":["trace[1606567504] 'read index received'  (duration: 98.75468ms)","trace[1606567504] 'applied index is now lower than readState.Index'  (duration: 146.961445ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:18.347317Z","caller":"traceutil/trace.go:171","msg":"trace[1908484914] transaction","detail":"{read_only:false; response_revision:25849; number_of_response:1; }","duration":"267.558698ms","start":"2026-07-29T22:42:18.079727Z","end":"2026-07-29T22:42:18.347286Z","steps":["trace[1908484914] 'process raft request'  (duration: 267.178949ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:18.347416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.914525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:42:18.347459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.942151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:42:18.347501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.955196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-29T22:42:18.349182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.997218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:42:18.349183Z","caller":"traceutil/trace.go:171","msg":"trace[1380571237] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:25850; }","duration":"247.677954ms","start":"2026-07-29T22:42:18.101474Z","end":"2026-07-29T22:42:18.349152Z","steps":["trace[1380571237] 'agreement among raft nodes before linearized reading'  (duration: 245.88422ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:18.349271Z","caller":"traceutil/trace.go:171","msg":"trace[1738743238] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:0; response_revision:25850; }","duration":"105.838643ms","start":"2026-07-29T22:42:18.243406Z","end":"2026-07-29T22:42:18.349244Z","steps":["trace[1738743238] 'agreement among raft nodes before linearized reading'  (duration: 104.038949ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:18.349518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.622277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:42:18.349604Z","caller":"traceutil/trace.go:171","msg":"trace[883772843] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:25850; }","duration":"105.7073ms","start":"2026-07-29T22:42:18.243864Z","end":"2026-07-29T22:42:18.349571Z","steps":["trace[883772843] 'agreement among raft nodes before linearized reading'  (duration: 103.558007ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:18.34976Z","caller":"traceutil/trace.go:171","msg":"trace[483502454] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:25850; }","duration":"105.646739ms","start":"2026-07-29T22:42:18.243498Z","end":"2026-07-29T22:42:18.349145Z","steps":["trace[483502454] 'agreement among raft nodes before linearized reading'  (duration: 103.896705ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:18.347287Z","caller":"traceutil/trace.go:171","msg":"trace[1363983816] transaction","detail":"{read_only:false; response_revision:25850; number_of_response:1; }","duration":"266.530743ms","start":"2026-07-29T22:42:18.080722Z","end":"2026-07-29T22:42:18.347253Z","steps":["trace[1363983816] 'process raft request'  (duration: 266.40719ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:18.350696Z","caller":"traceutil/trace.go:171","msg":"trace[649945883] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:25850; }","duration":"104.030168ms","start":"2026-07-29T22:42:18.243417Z","end":"2026-07-29T22:42:18.347448Z","steps":["trace[649945883] 'agreement among raft nodes before linearized reading'  (duration: 103.953376ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:18.475466Z","caller":"traceutil/trace.go:171","msg":"trace[1473786978] transaction","detail":"{read_only:false; response_revision:25851; number_of_response:1; }","duration":"119.804544ms","start":"2026-07-29T22:42:18.35563Z","end":"2026-07-29T22:42:18.475434Z","steps":["trace[1473786978] 'process raft request'  (duration: 119.554298ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:19.128373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.266497ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839764825 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25831 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-29T22:42:19.128508Z","caller":"traceutil/trace.go:171","msg":"trace[1046629102] transaction","detail":"{read_only:false; response_revision:25855; number_of_response:1; }","duration":"234.529942ms","start":"2026-07-29T22:42:18.893942Z","end":"2026-07-29T22:42:19.128472Z","steps":["trace[1046629102] 'process raft request'  (duration: 104.07392ms)","trace[1046629102] 'compare'  (duration: 130.139744ms)"],"step_count":2}
{"level":"info","ts":"2026-07-29T22:42:19.164342Z","caller":"traceutil/trace.go:171","msg":"trace[552889573] transaction","detail":"{read_only:false; response_revision:25856; number_of_response:1; }","duration":"254.456898ms","start":"2026-07-29T22:42:18.909842Z","end":"2026-07-29T22:42:19.164299Z","steps":["trace[552889573] 'process raft request'  (duration: 254.139881ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:19.164373Z","caller":"traceutil/trace.go:171","msg":"trace[2041689441] transaction","detail":"{read_only:false; response_revision:25857; number_of_response:1; }","duration":"254.13612ms","start":"2026-07-29T22:42:18.910197Z","end":"2026-07-29T22:42:19.164333Z","steps":["trace[2041689441] 'process raft request'  (duration: 253.957446ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:19.164424Z","caller":"traceutil/trace.go:171","msg":"trace[1633798266] transaction","detail":"{read_only:false; response_revision:25858; number_of_response:1; }","duration":"251.879495ms","start":"2026-07-29T22:42:18.912519Z","end":"2026-07-29T22:42:19.164398Z","steps":["trace[1633798266] 'process raft request'  (duration: 251.68537ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-29T22:42:19.330251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.980429ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757022091839764829 > lease_revoke:<id:34239fafdd6776ee>","response":"size:28"}
{"level":"info","ts":"2026-07-29T22:42:19.330386Z","caller":"traceutil/trace.go:171","msg":"trace[1763930326] linearizableReadLoop","detail":"{readStateIndex:26699; appliedIndex:26695; }","duration":"166.606775ms","start":"2026-07-29T22:42:19.163757Z","end":"2026-07-29T22:42:19.330364Z","steps":["trace[1763930326] 'read index received'  (duration: 122.083µs)","trace[1763930326] 'applied index is now lower than readState.Index'  (duration: 166.482872ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-29T22:42:19.330648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.863451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-29T22:42:19.330753Z","caller":"traceutil/trace.go:171","msg":"trace[1098773908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25858; }","duration":"167.001934ms","start":"2026-07-29T22:42:19.163721Z","end":"2026-07-29T22:42:19.330723Z","steps":["trace[1098773908] 'agreement among raft nodes before linearized reading'  (duration: 166.837281ms)"],"step_count":1}
{"level":"info","ts":"2026-07-29T22:42:30.861753Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22930}
{"level":"info","ts":"2026-07-29T22:42:31.00492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22930,"took":"140.091188ms","hash":3598088752,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":37597184,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-07-29T22:42:31.004986Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3598088752,"revision":22930,"compact-revision":20110}
{"level":"info","ts":"2026-07-29T22:47:30.868591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25971}
{"level":"info","ts":"2026-07-29T22:47:31.012742Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25971,"took":"140.841956ms","hash":212397191,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":34873344,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-07-29T22:47:31.012822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":212397191,"revision":25971,"compact-revision":22930}
{"level":"info","ts":"2026-07-29T22:48:25.317376Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":30004,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-29T22:48:25.322528Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30004}
{"level":"info","ts":"2026-07-29T22:48:25.322614Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25004}
{"level":"info","ts":"2026-07-29T22:52:30.876673Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28675}
{"level":"info","ts":"2026-07-29T22:52:31.013679Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28675,"took":"133.238161ms","hash":444398619,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":30408704,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-29T22:52:31.013755Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":444398619,"revision":28675,"compact-revision":25971}
{"level":"info","ts":"2026-07-29T22:57:30.883186Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30896}
{"level":"info","ts":"2026-07-29T22:57:31.004082Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30896,"took":"116.605847ms","hash":2518524139,"current-db-size-bytes":57880576,"current-db-size":"58 MB","current-db-size-in-use-bytes":31293440,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-29T22:57:31.004145Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2518524139,"revision":30896,"compact-revision":28675}
{"level":"info","ts":"2026-07-29T23:02:30.889373Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33163}
{"level":"info","ts":"2026-07-29T23:02:31.043141Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33163,"took":"148.098082ms","hash":4120177653,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":32210944,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-29T23:02:31.043238Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4120177653,"revision":33163,"compact-revision":30896}
{"level":"info","ts":"2026-07-29T23:07:30.896569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35517}
{"level":"info","ts":"2026-07-29T23:07:31.053096Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35517,"took":"151.804363ms","hash":2330923531,"current-db-size-bytes":59396096,"current-db-size":"59 MB","current-db-size-in-use-bytes":32301056,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-29T23:07:31.05319Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2330923531,"revision":35517,"compact-revision":33163}
{"level":"info","ts":"2026-07-29T23:09:43.486821Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":40005,"local-member-snapshot-index":30004,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-29T23:09:43.492438Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40005}
{"level":"info","ts":"2026-07-29T23:09:43.492559Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35005}
{"level":"info","ts":"2026-07-29T23:12:30.905391Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37786}
{"level":"info","ts":"2026-07-29T23:12:31.028466Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37786,"took":"119.045031ms","hash":4012986102,"current-db-size-bytes":59396096,"current-db-size":"59 MB","current-db-size-in-use-bytes":32198656,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-29T23:12:31.02852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4012986102,"revision":37786,"compact-revision":35517}