{"level":"warn","ts":"2026-06-12T03:14:27.5857Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-06-12T03:14:27.585786Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-06-12T03:14:27.585858Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-06-12T03:14:27.585867Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-06-12T03:14:27.585884Z","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-06-12T03:14:27.586621Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]}
{"level":"info","ts":"2026-06-12T03:14:27.586708Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-06-12T03:14:27.59036Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.435576ms"}
{"level":"info","ts":"2026-06-12T03:14:27.600068Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"}
{"level":"info","ts":"2026-06-12T03:14:27.600174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"}
{"level":"info","ts":"2026-06-12T03:14:27.600207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"}
{"level":"info","ts":"2026-06-12T03:14:27.600219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-06-12T03:14:27.600236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"}
{"level":"info","ts":"2026-06-12T03:14:27.600284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"warn","ts":"2026-06-12T03:14:27.608087Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-06-12T03:14:27.609433Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-06-12T03:14:27.610768Z","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-06-12T03:14:27.61513Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-06-12T03:14:27.615639Z","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-06-12T03:14:27.615756Z","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-06-12T03:14:27.615781Z","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-06-12T03:14:27.615747Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-06-12T03:14:27.616478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"info","ts":"2026-06-12T03:14:27.616627Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-06-12T03:14:27.620935Z","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-06-12T03:14:27.62119Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-06-12T03:14:27.621224Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-06-12T03:14:27.621259Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-06-12T03:14:27.621246Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-06-12T03:14:28.30886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"}
{"level":"info","ts":"2026-06-12T03:14:28.308953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"}
{"level":"info","ts":"2026-06-12T03:14:28.308998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"}
{"level":"info","ts":"2026-06-12T03:14:28.309026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"}
{"level":"info","ts":"2026-06-12T03:14:28.309038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-06-12T03:14:28.309053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"}
{"level":"info","ts":"2026-06-12T03:14:28.309067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-06-12T03:14:28.310948Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-12T03:14:28.312138Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-12T03:14:28.31216Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"}
{"level":"info","ts":"2026-06-12T03:14:28.312165Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-12T03:14:28.312688Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-06-12T03:14:28.312752Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-06-12T03:14:28.31402Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-06-12T03:14:28.314028Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"}
{"level":"info","ts":"2026-06-12T03:14:28.318239Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-12T03:14:28.318343Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-12T03:14:28.318374Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-06-12T03:14:42.182195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.030333ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187713421 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:320 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7230 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-12T03:14:42.182444Z","caller":"traceutil/trace.go:171","msg":"trace[2042656451] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"276.476769ms","start":"2026-06-12T03:14:41.905943Z","end":"2026-06-12T03:14:42.18242Z","steps":["trace[2042656451] 'process raft request'  (duration: 276.402918ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:14:42.182478Z","caller":"traceutil/trace.go:171","msg":"trace[166892410] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"297.163213ms","start":"2026-06-12T03:14:41.885288Z","end":"2026-06-12T03:14:42.182451Z","steps":["trace[166892410] 'process raft request'  (duration: 171.325974ms)","trace[166892410] 'compare'  (duration: 124.883581ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:14:42.388212Z","caller":"traceutil/trace.go:171","msg":"trace[951982321] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:419; }","duration":"109.861815ms","start":"2026-06-12T03:14:42.278317Z","end":"2026-06-12T03:14:42.388178Z","steps":["trace[951982321] 'read index received'  (duration: 97.330946ms)","trace[951982321] 'applied index is now lower than readState.Index'  (duration: 12.529739ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:14:42.388436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.072468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-06-12T03:14:42.388495Z","caller":"traceutil/trace.go:171","msg":"trace[1621609623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"110.232371ms","start":"2026-06-12T03:14:42.278246Z","end":"2026-06-12T03:14:42.388479Z","steps":["trace[1621609623] 'agreement among raft nodes before linearized reading'  (duration: 110.059538ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:14:42.388634Z","caller":"traceutil/trace.go:171","msg":"trace[933299017] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"193.169591ms","start":"2026-06-12T03:14:42.195438Z","end":"2026-06-12T03:14:42.388607Z","steps":["trace[933299017] 'process raft request'  (duration: 180.304437ms)","trace[933299017] 'compare'  (duration: 12.287784ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:15:07.148876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.771256ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187713731 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" mod_revision:570 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" value_size:29353 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-12T03:15:07.149088Z","caller":"traceutil/trace.go:171","msg":"trace[806444577] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"283.264807ms","start":"2026-06-12T03:15:06.865799Z","end":"2026-06-12T03:15:07.149064Z","steps":["trace[806444577] 'process raft request'  (duration: 125.215846ms)","trace[806444577] 'compare'  (duration: 157.617153ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:15:07.149255Z","caller":"traceutil/trace.go:171","msg":"trace[1784467873] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"251.48924ms","start":"2026-06-12T03:15:06.897716Z","end":"2026-06-12T03:15:07.149206Z","steps":["trace[1784467873] 'process raft request'  (duration: 251.306706ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:07.149392Z","caller":"traceutil/trace.go:171","msg":"trace[1693156053] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"236.400126ms","start":"2026-06-12T03:15:06.912976Z","end":"2026-06-12T03:15:07.149376Z","steps":["trace[1693156053] 'process raft request'  (duration: 236.209862ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:07.149367Z","caller":"traceutil/trace.go:171","msg":"trace[399020413] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"238.347393ms","start":"2026-06-12T03:15:06.910968Z","end":"2026-06-12T03:15:07.149316Z","steps":["trace[399020413] 'process raft request'  (duration: 238.146868ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:12.578803Z","caller":"traceutil/trace.go:171","msg":"trace[1060155482] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"185.956646ms","start":"2026-06-12T03:15:12.392809Z","end":"2026-06-12T03:15:12.578765Z","steps":["trace[1060155482] 'process raft request'  (duration: 185.303364ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:12.915777Z","caller":"traceutil/trace.go:171","msg":"trace[680260247] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"259.899858ms","start":"2026-06-12T03:15:12.655843Z","end":"2026-06-12T03:15:12.915743Z","steps":["trace[680260247] 'read index received'  (duration: 259.801697ms)","trace[680260247] 'applied index is now lower than readState.Index'  (duration: 96.941µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:15:12.91611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.05343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:15:12.915895Z","caller":"traceutil/trace.go:171","msg":"trace[13812920] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"273.24561ms","start":"2026-06-12T03:15:12.642616Z","end":"2026-06-12T03:15:12.915861Z","steps":["trace[13812920] 'process raft request'  (duration: 272.958584ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:12.916159Z","caller":"traceutil/trace.go:171","msg":"trace[798863672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"160.192833ms","start":"2026-06-12T03:15:12.755953Z","end":"2026-06-12T03:15:12.916146Z","steps":["trace[798863672] 'agreement among raft nodes before linearized reading'  (duration: 159.990089ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:15:12.916132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.274066ms","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-06-12T03:15:12.916211Z","caller":"traceutil/trace.go:171","msg":"trace[52022644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"260.397788ms","start":"2026-06-12T03:15:12.655793Z","end":"2026-06-12T03:15:12.916191Z","steps":["trace[52022644] 'agreement among raft nodes before linearized reading'  (duration: 260.083462ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:13.076789Z","caller":"traceutil/trace.go:171","msg":"trace[4518823] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"148.479552ms","start":"2026-06-12T03:15:12.928282Z","end":"2026-06-12T03:15:13.076762Z","steps":["trace[4518823] 'read index received'  (duration: 108.153243ms)","trace[4518823] 'applied index is now lower than readState.Index'  (duration: 40.324949ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:15:13.076932Z","caller":"traceutil/trace.go:171","msg":"trace[385299972] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"156.438461ms","start":"2026-06-12T03:15:12.920467Z","end":"2026-06-12T03:15:13.076905Z","steps":["trace[385299972] 'process raft request'  (duration: 116.023971ms)","trace[385299972] 'compare'  (duration: 40.090605ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:15:13.076997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.691626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:15:13.077042Z","caller":"traceutil/trace.go:171","msg":"trace[899023394] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:638; }","duration":"148.792018ms","start":"2026-06-12T03:15:12.928237Z","end":"2026-06-12T03:15:13.077029Z","steps":["trace[899023394] 'agreement among raft nodes before linearized reading'  (duration: 148.695736ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:15:28.463627Z","caller":"traceutil/trace.go:171","msg":"trace[1365489749] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"124.158014ms","start":"2026-06-12T03:15:28.339446Z","end":"2026-06-12T03:15:28.463604Z","steps":["trace[1365489749] 'process raft request'  (duration: 124.026022ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:15:58.901338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.773334ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187714959 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1199 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-12T03:15:58.901465Z","caller":"traceutil/trace.go:171","msg":"trace[1361346841] linearizableReadLoop","detail":"{readStateIndex:1238; appliedIndex:1237; }","duration":"144.252146ms","start":"2026-06-12T03:15:58.757195Z","end":"2026-06-12T03:15:58.901447Z","steps":["trace[1361346841] 'read index received'  (duration: 39.41µs)","trace[1361346841] 'applied index is now lower than readState.Index'  (duration: 144.211336ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:15:58.901473Z","caller":"traceutil/trace.go:171","msg":"trace[2041571843] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"217.276786ms","start":"2026-06-12T03:15:58.684182Z","end":"2026-06-12T03:15:58.901458Z","steps":["trace[2041571843] 'process raft request'  (duration: 69.287108ms)","trace[2041571843] 'compare'  (duration: 147.530259ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:15:58.901559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.365069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:15:58.901595Z","caller":"traceutil/trace.go:171","msg":"trace[2115592588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1205; }","duration":"144.44644ms","start":"2026-06-12T03:15:58.757138Z","end":"2026-06-12T03:15:58.901584Z","steps":["trace[2115592588] 'agreement among raft nodes before linearized reading'  (duration: 144.389509ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:15:58.902079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.6203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-06-12T03:15:58.902214Z","caller":"traceutil/trace.go:171","msg":"trace[1219912759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1205; }","duration":"125.795974ms","start":"2026-06-12T03:15:58.776385Z","end":"2026-06-12T03:15:58.902181Z","steps":["trace[1219912759] 'agreement among raft nodes before linearized reading'  (duration: 125.422007ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:17:39.084805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.89483ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187717118 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2216 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-12T03:17:39.084974Z","caller":"traceutil/trace.go:171","msg":"trace[213756977] linearizableReadLoop","detail":"{readStateIndex:2308; appliedIndex:2307; }","duration":"257.657111ms","start":"2026-06-12T03:17:38.827295Z","end":"2026-06-12T03:17:39.084952Z","steps":["trace[213756977] 'read index received'  (duration: 101.410585ms)","trace[213756977] 'applied index is now lower than readState.Index'  (duration: 156.244806ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:17:39.085076Z","caller":"traceutil/trace.go:171","msg":"trace[732083513] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"279.050968ms","start":"2026-06-12T03:17:38.805979Z","end":"2026-06-12T03:17:39.08503Z","steps":["trace[732083513] 'process raft request'  (duration: 122.798581ms)","trace[732083513] 'compare'  (duration: 155.684335ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:17:39.085227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.313538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-06-12T03:17:39.085208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.057459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:17:39.085271Z","caller":"traceutil/trace.go:171","msg":"trace[127171041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2226; }","duration":"237.40198ms","start":"2026-06-12T03:17:38.847857Z","end":"2026-06-12T03:17:39.085259Z","steps":["trace[127171041] 'agreement among raft nodes before linearized reading'  (duration: 237.221257ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:17:39.085304Z","caller":"traceutil/trace.go:171","msg":"trace[686224583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2226; }","duration":"267.201721ms","start":"2026-06-12T03:17:38.81808Z","end":"2026-06-12T03:17:39.085282Z","steps":["trace[686224583] 'agreement among raft nodes before linearized reading'  (duration: 267.007508ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:19:01.886038Z","caller":"traceutil/trace.go:171","msg":"trace[74338421] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"105.383583ms","start":"2026-06-12T03:19:01.78062Z","end":"2026-06-12T03:19:01.886003Z","steps":["trace[74338421] 'process raft request'  (duration: 105.137389ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:19:02.023903Z","caller":"traceutil/trace.go:171","msg":"trace[1287331679] transaction","detail":"{read_only:false; response_revision:2874; number_of_response:1; }","duration":"133.11819ms","start":"2026-06-12T03:19:01.890761Z","end":"2026-06-12T03:19:02.023879Z","steps":["trace[1287331679] 'process raft request'  (duration: 133.057719ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:19:02.023905Z","caller":"traceutil/trace.go:171","msg":"trace[389931325] transaction","detail":"{read_only:false; response_revision:2873; number_of_response:1; }","duration":"133.607309ms","start":"2026-06-12T03:19:01.890266Z","end":"2026-06-12T03:19:02.023873Z","steps":["trace[389931325] 'process raft request'  (duration: 125.808192ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:21:22.255979Z","caller":"traceutil/trace.go:171","msg":"trace[1444609220] transaction","detail":"{read_only:false; response_revision:3810; number_of_response:1; }","duration":"133.456661ms","start":"2026-06-12T03:21:22.122487Z","end":"2026-06-12T03:21:22.255943Z","steps":["trace[1444609220] 'process raft request'  (duration: 133.219517ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:22:48.729625Z","caller":"traceutil/trace.go:171","msg":"trace[232217178] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"121.309138ms","start":"2026-06-12T03:22:48.608284Z","end":"2026-06-12T03:22:48.729593Z","steps":["trace[232217178] 'process raft request'  (duration: 31.204031ms)","trace[232217178] 'compare'  (duration: 89.905903ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:22:50.712699Z","caller":"traceutil/trace.go:171","msg":"trace[1981670553] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"226.098494ms","start":"2026-06-12T03:22:50.486556Z","end":"2026-06-12T03:22:50.712654Z","steps":["trace[1981670553] 'process raft request'  (duration: 189.00113ms)","trace[1981670553] 'compare'  (duration: 36.739906ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:22:50.714504Z","caller":"traceutil/trace.go:171","msg":"trace[1912781448] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"227.897458ms","start":"2026-06-12T03:22:50.486574Z","end":"2026-06-12T03:22:50.714471Z","steps":["trace[1912781448] 'process raft request'  (duration: 227.739745ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:22:52.407125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.603341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-27vnv\" ","response":"range_response_count:1 size:6445"}
{"level":"info","ts":"2026-06-12T03:22:52.407225Z","caller":"traceutil/trace.go:171","msg":"trace[1054402139] range","detail":"{range_begin:/registry/pods/openstack/keepalived-27vnv; range_end:; response_count:1; response_revision:5014; }","duration":"115.765993ms","start":"2026-06-12T03:22:52.291437Z","end":"2026-06-12T03:22:52.407203Z","steps":["trace[1054402139] 'range keys from in-memory index tree'  (duration: 115.389416ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:23:07.088376Z","caller":"traceutil/trace.go:171","msg":"trace[36378019] linearizableReadLoop","detail":"{readStateIndex:5508; appliedIndex:5507; }","duration":"115.740613ms","start":"2026-06-12T03:23:06.972605Z","end":"2026-06-12T03:23:07.088345Z","steps":["trace[36378019] 'read index received'  (duration: 76.383196ms)","trace[36378019] 'applied index is now lower than readState.Index'  (duration: 39.356017ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:23:07.088538Z","caller":"traceutil/trace.go:171","msg":"trace[1354711172] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"207.751686ms","start":"2026-06-12T03:23:06.880771Z","end":"2026-06-12T03:23:07.088523Z","steps":["trace[1354711172] 'process raft request'  (duration: 168.255727ms)","trace[1354711172] 'compare'  (duration: 39.097981ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:23:07.088904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.629109ms","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-06-12T03:23:07.089021Z","caller":"traceutil/trace.go:171","msg":"trace[80611926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5310; }","duration":"108.792772ms","start":"2026-06-12T03:23:06.980205Z","end":"2026-06-12T03:23:07.088998Z","steps":["trace[80611926] 'agreement among raft nodes before linearized reading'  (duration: 108.441685ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:23:07.088914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.290744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-06-12T03:23:07.089145Z","caller":"traceutil/trace.go:171","msg":"trace[383345631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5310; }","duration":"116.553729ms","start":"2026-06-12T03:23:06.972549Z","end":"2026-06-12T03:23:07.089102Z","steps":["trace[383345631] 'agreement among raft nodes before linearized reading'  (duration: 116.102801ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:23:07.232649Z","caller":"traceutil/trace.go:171","msg":"trace[878564170] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"127.604098ms","start":"2026-06-12T03:23:07.105014Z","end":"2026-06-12T03:23:07.232618Z","steps":["trace[878564170] 'process raft request'  (duration: 127.530427ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:23:07.232791Z","caller":"traceutil/trace.go:171","msg":"trace[1471190995] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"127.930565ms","start":"2026-06-12T03:23:07.104816Z","end":"2026-06-12T03:23:07.232746Z","steps":["trace[1471190995] 'process raft request'  (duration: 111.281029ms)","trace[1471190995] 'compare'  (duration: 16.249157ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:23:15.338035Z","caller":"traceutil/trace.go:171","msg":"trace[1631184292] transaction","detail":"{read_only:false; response_revision:5497; number_of_response:1; }","duration":"124.041841ms","start":"2026-06-12T03:23:15.213966Z","end":"2026-06-12T03:23:15.338008Z","steps":["trace[1631184292] 'process raft request'  (duration: 123.795735ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:23:15.445503Z","caller":"traceutil/trace.go:171","msg":"trace[1984099070] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"101.474672ms","start":"2026-06-12T03:23:15.344001Z","end":"2026-06-12T03:23:15.445475Z","steps":["trace[1984099070] 'process raft request'  (duration: 101.395611ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:23:15.445547Z","caller":"traceutil/trace.go:171","msg":"trace[1934480052] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"101.572854ms","start":"2026-06-12T03:23:15.343916Z","end":"2026-06-12T03:23:15.445489Z","steps":["trace[1934480052] 'process raft request'  (duration: 29.944867ms)","trace[1934480052] 'compare'  (duration: 71.370152ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:24:28.332803Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3017}
{"level":"info","ts":"2026-06-12T03:24:28.425216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3017,"took":"90.388556ms","hash":1398015651,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":31801344,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-12T03:24:28.4253Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1398015651,"revision":3017,"compact-revision":-1}
{"level":"info","ts":"2026-06-12T03:29:28.340588Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6135}
{"level":"info","ts":"2026-06-12T03:29:28.441048Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6135,"took":"98.073155ms","hash":2466502702,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":23842816,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-06-12T03:29:28.441139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2466502702,"revision":6135,"compact-revision":3017}
{"level":"info","ts":"2026-06-12T03:30:05.871356Z","caller":"traceutil/trace.go:171","msg":"trace[1800448326] linearizableReadLoop","detail":"{readStateIndex:8883; appliedIndex:8882; }","duration":"230.687017ms","start":"2026-06-12T03:30:05.640635Z","end":"2026-06-12T03:30:05.871322Z","steps":["trace[1800448326] 'read index received'  (duration: 205.652291ms)","trace[1800448326] 'applied index is now lower than readState.Index'  (duration: 25.033626ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:30:05.871522Z","caller":"traceutil/trace.go:171","msg":"trace[1823380018] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"304.38879ms","start":"2026-06-12T03:30:05.567092Z","end":"2026-06-12T03:30:05.871481Z","steps":["trace[1823380018] 'process raft request'  (duration: 279.324083ms)","trace[1823380018] 'compare'  (duration: 24.484756ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:30:05.871682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.020904ms","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-06-12T03:30:05.871714Z","caller":"traceutil/trace.go:171","msg":"trace[358669307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8583; }","duration":"231.100575ms","start":"2026-06-12T03:30:05.640604Z","end":"2026-06-12T03:30:05.871704Z","steps":["trace[358669307] 'agreement among raft nodes before linearized reading'  (duration: 230.882701ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:30:05.871705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:30:05.567084Z","time spent":"304.530133ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8574 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-06-12T03:30:05.872032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.282943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-06-12T03:30:05.872055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.327155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-06-12T03:30:05.87206Z","caller":"traceutil/trace.go:171","msg":"trace[968844683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8583; }","duration":"104.336194ms","start":"2026-06-12T03:30:05.767718Z","end":"2026-06-12T03:30:05.872054Z","steps":["trace[968844683] 'agreement among raft nodes before linearized reading'  (duration: 104.263543ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:05.872083Z","caller":"traceutil/trace.go:171","msg":"trace[1995051679] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8583; }","duration":"175.410936ms","start":"2026-06-12T03:30:05.696664Z","end":"2026-06-12T03:30:05.872075Z","steps":["trace[1995051679] 'agreement among raft nodes before linearized reading'  (duration: 175.300074ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:30:05.872112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.332133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:30:05.872208Z","caller":"traceutil/trace.go:171","msg":"trace[2007877855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8583; }","duration":"115.510516ms","start":"2026-06-12T03:30:05.756677Z","end":"2026-06-12T03:30:05.872188Z","steps":["trace[2007877855] 'agreement among raft nodes before linearized reading'  (duration: 115.323433ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:06.052842Z","caller":"traceutil/trace.go:171","msg":"trace[1324164304] linearizableReadLoop","detail":"{readStateIndex:8884; appliedIndex:8883; }","duration":"179.220629ms","start":"2026-06-12T03:30:05.87355Z","end":"2026-06-12T03:30:06.05277Z","steps":["trace[1324164304] 'read index received'  (duration: 130.222277ms)","trace[1324164304] 'applied index is now lower than readState.Index'  (duration: 48.996202ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:30:06.053051Z","caller":"traceutil/trace.go:171","msg":"trace[518522429] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"179.717789ms","start":"2026-06-12T03:30:05.873283Z","end":"2026-06-12T03:30:06.053001Z","steps":["trace[518522429] 'process raft request'  (duration: 130.466692ms)","trace[518522429] 'compare'  (duration: 48.763127ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:30:06.05316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.567426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:30:06.053295Z","caller":"traceutil/trace.go:171","msg":"trace[785502023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8584; }","duration":"179.717669ms","start":"2026-06-12T03:30:05.873527Z","end":"2026-06-12T03:30:06.053245Z","steps":["trace[785502023] 'agreement among raft nodes before linearized reading'  (duration: 179.449664ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:06.061126Z","caller":"traceutil/trace.go:171","msg":"trace[254726588] transaction","detail":"{read_only:false; response_revision:8587; number_of_response:1; }","duration":"181.9405ms","start":"2026-06-12T03:30:05.879147Z","end":"2026-06-12T03:30:06.061088Z","steps":["trace[254726588] 'process raft request'  (duration: 181.863219ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:06.06123Z","caller":"traceutil/trace.go:171","msg":"trace[979770897] transaction","detail":"{read_only:false; response_revision:8586; number_of_response:1; }","duration":"183.122833ms","start":"2026-06-12T03:30:05.878092Z","end":"2026-06-12T03:30:06.061215Z","steps":["trace[979770897] 'process raft request'  (duration: 182.879588ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:06.061156Z","caller":"traceutil/trace.go:171","msg":"trace[1728164297] transaction","detail":"{read_only:false; response_revision:8585; number_of_response:1; }","duration":"184.865427ms","start":"2026-06-12T03:30:05.876243Z","end":"2026-06-12T03:30:06.061108Z","steps":["trace[1728164297] 'process raft request'  (duration: 184.567351ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:08.900997Z","caller":"traceutil/trace.go:171","msg":"trace[948720230] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"133.095491ms","start":"2026-06-12T03:30:08.767875Z","end":"2026-06-12T03:30:08.90097Z","steps":["trace[948720230] 'process raft request'  (duration: 132.930697ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:08.930505Z","caller":"traceutil/trace.go:171","msg":"trace[122727678] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"151.409649ms","start":"2026-06-12T03:30:08.779077Z","end":"2026-06-12T03:30:08.930487Z","steps":["trace[122727678] 'process raft request'  (duration: 151.321598ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:30:19.904876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.916177ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187733293 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8676 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-12T03:30:19.905008Z","caller":"traceutil/trace.go:171","msg":"trace[540848517] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"191.736357ms","start":"2026-06-12T03:30:19.713247Z","end":"2026-06-12T03:30:19.904984Z","steps":["trace[540848517] 'process raft request'  (duration: 87.608196ms)","trace[540848517] 'compare'  (duration: 103.758084ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:30:20.064613Z","caller":"traceutil/trace.go:171","msg":"trace[1522005438] transaction","detail":"{read_only:false; response_revision:8702; number_of_response:1; }","duration":"105.017948ms","start":"2026-06-12T03:30:19.959565Z","end":"2026-06-12T03:30:20.064583Z","steps":["trace[1522005438] 'process raft request'  (duration: 99.455552ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:30:37.029126Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f8.wal"}
{"level":"info","ts":"2026-06-12T03:31:36.622857Z","caller":"traceutil/trace.go:171","msg":"trace[1262983035] linearizableReadLoop","detail":"{readStateIndex:9779; appliedIndex:9776; }","duration":"143.55856ms","start":"2026-06-12T03:31:36.479264Z","end":"2026-06-12T03:31:36.622822Z","steps":["trace[1262983035] 'read index received'  (duration: 86.27323ms)","trace[1262983035] 'applied index is now lower than readState.Index'  (duration: 57.28409ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:31:36.622972Z","caller":"traceutil/trace.go:171","msg":"trace[432855545] transaction","detail":"{read_only:false; response_revision:9450; number_of_response:1; }","duration":"172.413839ms","start":"2026-06-12T03:31:36.450506Z","end":"2026-06-12T03:31:36.62292Z","steps":["trace[432855545] 'process raft request'  (duration: 172.235305ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:31:36.622887Z","caller":"traceutil/trace.go:171","msg":"trace[1644063810] transaction","detail":"{read_only:false; response_revision:9449; number_of_response:1; }","duration":"172.646313ms","start":"2026-06-12T03:31:36.450194Z","end":"2026-06-12T03:31:36.622841Z","steps":["trace[1644063810] 'process raft request'  (duration: 172.286447ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:31:36.623299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.002638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-06-12T03:31:36.623421Z","caller":"traceutil/trace.go:171","msg":"trace[1531471387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9450; }","duration":"144.209602ms","start":"2026-06-12T03:31:36.479182Z","end":"2026-06-12T03:31:36.623391Z","steps":["trace[1531471387] 'agreement among raft nodes before linearized reading'  (duration: 143.815264ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:32:06.736183Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-12T03:32:06.741936Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-06-12T03:32:06.742011Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-06-12T03:34:28.346815Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8329}
{"level":"info","ts":"2026-06-12T03:34:28.4307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8329,"took":"80.978503ms","hash":1611603623,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":26423296,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-06-12T03:34:28.43078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1611603623,"revision":8329,"compact-revision":6135}
{"level":"info","ts":"2026-06-12T03:35:01.908406Z","caller":"traceutil/trace.go:171","msg":"trace[1438350714] transaction","detail":"{read_only:false; response_revision:11196; number_of_response:1; }","duration":"119.580388ms","start":"2026-06-12T03:35:01.78878Z","end":"2026-06-12T03:35:01.90836Z","steps":["trace[1438350714] 'process raft request'  (duration: 37.609046ms)","trace[1438350714] 'compare'  (duration: 81.700976ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:39:28.356628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10822}
{"level":"info","ts":"2026-06-12T03:39:28.44149Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10822,"took":"81.820348ms","hash":1713092104,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":26968064,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-06-12T03:39:28.441554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1713092104,"revision":10822,"compact-revision":8329}
{"level":"info","ts":"2026-06-12T03:41:18.958227Z","caller":"traceutil/trace.go:171","msg":"trace[1518851921] transaction","detail":"{read_only:false; response_revision:13733; number_of_response:1; }","duration":"105.814155ms","start":"2026-06-12T03:41:18.852382Z","end":"2026-06-12T03:41:18.958196Z","steps":["trace[1518851921] 'process raft request'  (duration: 105.634622ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:41:58.331154Z","caller":"traceutil/trace.go:171","msg":"trace[951746162] linearizableReadLoop","detail":"{readStateIndex:14433; appliedIndex:14432; }","duration":"121.774339ms","start":"2026-06-12T03:41:58.209346Z","end":"2026-06-12T03:41:58.331121Z","steps":["trace[951746162] 'read index received'  (duration: 121.478434ms)","trace[951746162] 'applied index is now lower than readState.Index'  (duration: 294.515µs)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:41:58.331279Z","caller":"traceutil/trace.go:171","msg":"trace[1511531716] transaction","detail":"{read_only:false; response_revision:13956; number_of_response:1; }","duration":"138.560889ms","start":"2026-06-12T03:41:58.192673Z","end":"2026-06-12T03:41:58.331234Z","steps":["trace[1511531716] 'process raft request'  (duration: 138.245543ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:41:58.331561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.857282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-06-12T03:41:58.331622Z","caller":"traceutil/trace.go:171","msg":"trace[955699401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13956; }","duration":"118.953214ms","start":"2026-06-12T03:41:58.212656Z","end":"2026-06-12T03:41:58.331609Z","steps":["trace[955699401] 'agreement among raft nodes before linearized reading'  (duration: 118.73586ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:41:58.331644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.309422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-06-12T03:41:58.331644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.283758ms","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-06-12T03:41:58.33171Z","caller":"traceutil/trace.go:171","msg":"trace[405547097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13956; }","duration":"108.412445ms","start":"2026-06-12T03:41:58.223281Z","end":"2026-06-12T03:41:58.331693Z","steps":["trace[405547097] 'agreement among raft nodes before linearized reading'  (duration: 108.123989ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:41:58.331739Z","caller":"traceutil/trace.go:171","msg":"trace[140553602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13956; }","duration":"112.414942ms","start":"2026-06-12T03:41:58.219301Z","end":"2026-06-12T03:41:58.331716Z","steps":["trace[140553602] 'agreement among raft nodes before linearized reading'  (duration: 112.154666ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:41:58.33177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.33081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-06-12T03:41:58.331933Z","caller":"traceutil/trace.go:171","msg":"trace[30629327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13956; }","duration":"122.585815ms","start":"2026-06-12T03:41:58.209296Z","end":"2026-06-12T03:41:58.331882Z","steps":["trace[30629327] 'agreement among raft nodes before linearized reading'  (duration: 121.954462ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:41:58.47845Z","caller":"traceutil/trace.go:171","msg":"trace[1703132079] transaction","detail":"{read_only:false; response_revision:13957; number_of_response:1; }","duration":"139.959895ms","start":"2026-06-12T03:41:58.338414Z","end":"2026-06-12T03:41:58.478374Z","steps":["trace[1703132079] 'process raft request'  (duration: 139.743171ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:41:58.489655Z","caller":"traceutil/trace.go:171","msg":"trace[1459902460] transaction","detail":"{read_only:false; response_revision:13958; number_of_response:1; }","duration":"150.639028ms","start":"2026-06-12T03:41:58.338985Z","end":"2026-06-12T03:41:58.489624Z","steps":["trace[1459902460] 'process raft request'  (duration: 150.414114ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:41:58.489955Z","caller":"traceutil/trace.go:171","msg":"trace[30931080] transaction","detail":"{read_only:false; response_revision:13959; number_of_response:1; }","duration":"150.882823ms","start":"2026-06-12T03:41:58.339029Z","end":"2026-06-12T03:41:58.489912Z","steps":["trace[30931080] 'process raft request'  (duration: 150.548066ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:41:58.490136Z","caller":"traceutil/trace.go:171","msg":"trace[1572583450] transaction","detail":"{read_only:false; response_revision:13960; number_of_response:1; }","duration":"150.67713ms","start":"2026-06-12T03:41:58.339441Z","end":"2026-06-12T03:41:58.490118Z","steps":["trace[1572583450] 'process raft request'  (duration: 150.381524ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:42:07.321269Z","caller":"traceutil/trace.go:171","msg":"trace[1624046214] transaction","detail":"{read_only:false; response_revision:14124; number_of_response:1; }","duration":"228.214356ms","start":"2026-06-12T03:42:07.093004Z","end":"2026-06-12T03:42:07.321218Z","steps":["trace[1624046214] 'process raft request'  (duration: 128.424796ms)","trace[1624046214] 'compare'  (duration: 99.310121ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:42:07.392004Z","caller":"traceutil/trace.go:171","msg":"trace[1855989206] transaction","detail":"{read_only:false; response_revision:14125; number_of_response:1; }","duration":"237.153377ms","start":"2026-06-12T03:42:07.154818Z","end":"2026-06-12T03:42:07.391971Z","steps":["trace[1855989206] 'process raft request'  (duration: 236.948112ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:42:07.392168Z","caller":"traceutil/trace.go:171","msg":"trace[1045371615] transaction","detail":"{read_only:false; response_revision:14126; number_of_response:1; }","duration":"236.381142ms","start":"2026-06-12T03:42:07.155748Z","end":"2026-06-12T03:42:07.392129Z","steps":["trace[1045371615] 'process raft request'  (duration: 236.183028ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:42:07.623363Z","caller":"traceutil/trace.go:171","msg":"trace[2054011198] linearizableReadLoop","detail":"{readStateIndex:14607; appliedIndex:14604; }","duration":"298.346521ms","start":"2026-06-12T03:42:07.32498Z","end":"2026-06-12T03:42:07.623326Z","steps":["trace[2054011198] 'read index received'  (duration: 66.73615ms)","trace[2054011198] 'applied index is now lower than readState.Index'  (duration: 231.608601ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:42:07.623565Z","caller":"traceutil/trace.go:171","msg":"trace[615361676] transaction","detail":"{read_only:false; response_revision:14127; number_of_response:1; }","duration":"363.35668ms","start":"2026-06-12T03:42:07.260158Z","end":"2026-06-12T03:42:07.623515Z","steps":["trace[615361676] 'process raft request'  (duration: 265.672049ms)","trace[615361676] 'compare'  (duration: 97.137131ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T03:42:07.623731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.736448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-nf4w2\" ","response":"range_response_count:1 size:12384"}
{"level":"info","ts":"2026-06-12T03:42:07.623822Z","caller":"traceutil/trace.go:171","msg":"trace[1601194915] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-nf4w2; range_end:; response_count:1; response_revision:14127; }","duration":"298.876901ms","start":"2026-06-12T03:42:07.324923Z","end":"2026-06-12T03:42:07.6238Z","steps":["trace[1601194915] 'agreement among raft nodes before linearized reading'  (duration: 298.582686ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:42:07.623958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:42:07.26012Z","time spent":"363.653006ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:13947 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-06-12T03:43:38.921321Z","caller":"traceutil/trace.go:171","msg":"trace[92747437] transaction","detail":"{read_only:false; response_revision:15168; number_of_response:1; }","duration":"151.050613ms","start":"2026-06-12T03:43:38.770237Z","end":"2026-06-12T03:43:38.921288Z","steps":["trace[92747437] 'process raft request'  (duration: 150.853659ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:43:39.157929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.496545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-06-12T03:43:39.158156Z","caller":"traceutil/trace.go:171","msg":"trace[1271082254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15168; }","duration":"158.757541ms","start":"2026-06-12T03:43:38.999376Z","end":"2026-06-12T03:43:39.158134Z","steps":["trace[1271082254] 'range keys from in-memory index tree'  (duration: 158.345953ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:43:39.158219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.825175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-06-12T03:43:39.157999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.060886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-12T03:43:39.158362Z","caller":"traceutil/trace.go:171","msg":"trace[801406300] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15168; }","duration":"167.002588ms","start":"2026-06-12T03:43:38.991336Z","end":"2026-06-12T03:43:39.158338Z","steps":["trace[801406300] 'range keys from in-memory index tree'  (duration: 166.655641ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:43:39.158421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.746849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-06-12T03:43:39.158519Z","caller":"traceutil/trace.go:171","msg":"trace[548279147] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15168; }","duration":"169.881543ms","start":"2026-06-12T03:43:38.988613Z","end":"2026-06-12T03:43:39.158495Z","steps":["trace[548279147] 'range keys from in-memory index tree'  (duration: 169.392623ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:43:39.158462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.255198ms","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-06-12T03:43:39.158399Z","caller":"traceutil/trace.go:171","msg":"trace[2013430416] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15168; }","duration":"138.488035ms","start":"2026-06-12T03:43:39.019878Z","end":"2026-06-12T03:43:39.158366Z","steps":["trace[2013430416] 'range keys from in-memory index tree'  (duration: 137.974134ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:43:39.158632Z","caller":"traceutil/trace.go:171","msg":"trace[1991207455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15168; }","duration":"161.431391ms","start":"2026-06-12T03:43:38.997144Z","end":"2026-06-12T03:43:39.158575Z","steps":["trace[1991207455] 'range keys from in-memory index tree'  (duration: 160.850601ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:43:39.159051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.175639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-06-12T03:43:39.159111Z","caller":"traceutil/trace.go:171","msg":"trace[1204775586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15168; }","duration":"160.102636ms","start":"2026-06-12T03:43:38.998994Z","end":"2026-06-12T03:43:39.159097Z","steps":["trace[1204775586] 'range keys from in-memory index tree'  (duration: 159.014776ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:44:28.364923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12888}
{"level":"info","ts":"2026-06-12T03:44:28.441071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12888,"took":"73.298015ms","hash":1906688971,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":30601216,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-12T03:44:28.441137Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1906688971,"revision":12888,"compact-revision":10822}
{"level":"info","ts":"2026-06-12T03:49:23.161636Z","caller":"traceutil/trace.go:171","msg":"trace[327293005] transaction","detail":"{read_only:false; response_revision:17693; number_of_response:1; }","duration":"253.542735ms","start":"2026-06-12T03:49:22.908061Z","end":"2026-06-12T03:49:23.161604Z","steps":["trace[327293005] 'process raft request'  (duration: 253.30272ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:49:23.162423Z","caller":"traceutil/trace.go:171","msg":"trace[1239799736] linearizableReadLoop","detail":"{readStateIndex:18292; appliedIndex:18290; }","duration":"190.44036ms","start":"2026-06-12T03:49:22.971949Z","end":"2026-06-12T03:49:23.162389Z","steps":["trace[1239799736] 'read index received'  (duration: 189.337769ms)","trace[1239799736] 'applied index is now lower than readState.Index'  (duration: 1.101061ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:49:23.162485Z","caller":"traceutil/trace.go:171","msg":"trace[708322650] transaction","detail":"{read_only:false; response_revision:17694; number_of_response:1; }","duration":"231.937339ms","start":"2026-06-12T03:49:22.930514Z","end":"2026-06-12T03:49:23.162451Z","steps":["trace[708322650] 'process raft request'  (duration: 231.600792ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:23.163191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.34704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-06-12T03:49:23.163199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.741684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T03:49:23.163263Z","caller":"traceutil/trace.go:171","msg":"trace[1717413556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17695; }","duration":"138.454102ms","start":"2026-06-12T03:49:23.024785Z","end":"2026-06-12T03:49:23.163239Z","steps":["trace[1717413556] 'agreement among raft nodes before linearized reading'  (duration: 138.149477ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:23.163255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.097617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-06-12T03:49:23.163247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.269835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-06-12T03:49:23.16332Z","caller":"traceutil/trace.go:171","msg":"trace[1698958380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17695; }","duration":"136.238389ms","start":"2026-06-12T03:49:23.027066Z","end":"2026-06-12T03:49:23.163304Z","steps":["trace[1698958380] 'agreement among raft nodes before linearized reading'  (duration: 135.749261ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:23.163313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.580358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-06-12T03:49:23.163329Z","caller":"traceutil/trace.go:171","msg":"trace[372502918] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:17695; }","duration":"124.933927ms","start":"2026-06-12T03:49:23.038362Z","end":"2026-06-12T03:49:23.163296Z","steps":["trace[372502918] 'agreement among raft nodes before linearized reading'  (duration: 124.303996ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:49:23.163341Z","caller":"traceutil/trace.go:171","msg":"trace[1560067261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17695; }","duration":"191.433198ms","start":"2026-06-12T03:49:22.971889Z","end":"2026-06-12T03:49:23.163322Z","steps":["trace[1560067261] 'agreement among raft nodes before linearized reading'  (duration: 190.678474ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:49:23.163363Z","caller":"traceutil/trace.go:171","msg":"trace[1825313509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17695; }","duration":"143.70035ms","start":"2026-06-12T03:49:23.01965Z","end":"2026-06-12T03:49:23.163351Z","steps":["trace[1825313509] 'agreement among raft nodes before linearized reading'  (duration: 142.923346ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:49:28.372112Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15482}
{"level":"info","ts":"2026-06-12T03:49:28.475573Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15482,"took":"99.783705ms","hash":2786487676,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":32149504,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-12T03:49:28.475667Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2786487676,"revision":15482,"compact-revision":12888}
{"level":"info","ts":"2026-06-12T03:49:29.615585Z","caller":"traceutil/trace.go:171","msg":"trace[1211816422] transaction","detail":"{read_only:false; response_revision:17823; number_of_response:1; }","duration":"477.234488ms","start":"2026-06-12T03:49:29.138308Z","end":"2026-06-12T03:49:29.615543Z","steps":["trace[1211816422] 'process raft request'  (duration: 477.066035ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:29.615771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.138256Z","time spent":"477.431073ms","remote":"127.0.0.1:35866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2958,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/openstack/rabbitmq-heat-server-0\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rabbitmq-heat-server-0\" value_size:2882 >> failure:<>"}
{"level":"info","ts":"2026-06-12T03:49:29.624912Z","caller":"traceutil/trace.go:171","msg":"trace[1907075176] linearizableReadLoop","detail":"{readStateIndex:18425; appliedIndex:18423; }","duration":"416.538128ms","start":"2026-06-12T03:49:29.208335Z","end":"2026-06-12T03:49:29.624874Z","steps":["trace[1907075176] 'read index received'  (duration: 407.981177ms)","trace[1907075176] 'applied index is now lower than readState.Index'  (duration: 8.555601ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:49:29.625393Z","caller":"traceutil/trace.go:171","msg":"trace[1618333215] transaction","detail":"{read_only:false; response_revision:17824; number_of_response:1; }","duration":"440.961946ms","start":"2026-06-12T03:49:29.184415Z","end":"2026-06-12T03:49:29.625377Z","steps":["trace[1618333215] 'process raft request'  (duration: 440.243953ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:29.625661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.184386Z","time spent":"441.10045ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:17798 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-12T03:49:29.625915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.573024ms","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-06-12T03:49:29.626004Z","caller":"traceutil/trace.go:171","msg":"trace[340357614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17825; }","duration":"412.727777ms","start":"2026-06-12T03:49:29.213254Z","end":"2026-06-12T03:49:29.625982Z","steps":["trace[340357614] 'agreement among raft nodes before linearized reading'  (duration: 412.461942ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:29.626058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.213233Z","time spent":"412.816268ms","remote":"127.0.0.1:54452","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-06-12T03:49:29.626302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.901893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-06-12T03:49:29.626364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.672556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-06-12T03:49:29.626405Z","caller":"traceutil/trace.go:171","msg":"trace[1701899421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17825; }","duration":"412.770937ms","start":"2026-06-12T03:49:29.213624Z","end":"2026-06-12T03:49:29.626395Z","steps":["trace[1701899421] 'agreement among raft nodes before linearized reading'  (duration: 412.632795ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:49:29.626411Z","caller":"traceutil/trace.go:171","msg":"trace[1984203991] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17825; }","duration":"418.099137ms","start":"2026-06-12T03:49:29.208281Z","end":"2026-06-12T03:49:29.62638Z","steps":["trace[1984203991] 'agreement among raft nodes before linearized reading'  (duration: 417.70619ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:29.62644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.213599Z","time spent":"412.834828ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-06-12T03:49:29.626469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.208265Z","time spent":"418.192739ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-06-12T03:49:29.626577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.223426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-06-12T03:49:29.62661Z","caller":"traceutil/trace.go:171","msg":"trace[1815997081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17825; }","duration":"413.269856ms","start":"2026-06-12T03:49:29.213331Z","end":"2026-06-12T03:49:29.626601Z","steps":["trace[1815997081] 'agreement among raft nodes before linearized reading'  (duration: 413.183605ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:49:29.626644Z","caller":"traceutil/trace.go:171","msg":"trace[512714313] transaction","detail":"{read_only:false; response_revision:17825; number_of_response:1; }","duration":"423.402697ms","start":"2026-06-12T03:49:29.203227Z","end":"2026-06-12T03:49:29.62663Z","steps":["trace[512714313] 'process raft request'  (duration: 421.593613ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:49:29.62676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.203198Z","time spent":"423.480919ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17799 > 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-06-12T03:49:29.626637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:49:29.213326Z","time spent":"413.305647ms","remote":"127.0.0.1:54452","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-06-12T03:52:40.665811Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-12T03:52:40.670939Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-06-12T03:52:40.671044Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-06-12T03:54:28.378032Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17813}
{"level":"info","ts":"2026-06-12T03:54:28.47836Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17813,"took":"96.306748ms","hash":1202435652,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":34447360,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-06-12T03:54:28.47842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1202435652,"revision":17813,"compact-revision":15482}
{"level":"info","ts":"2026-06-12T03:54:57.558103Z","caller":"traceutil/trace.go:171","msg":"trace[117480064] transaction","detail":"{read_only:false; response_revision:20335; number_of_response:1; }","duration":"200.835232ms","start":"2026-06-12T03:54:57.357236Z","end":"2026-06-12T03:54:57.558071Z","steps":["trace[117480064] 'process raft request'  (duration: 101.612679ms)","trace[117480064] 'compare'  (duration: 99.010919ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T03:54:57.558438Z","caller":"traceutil/trace.go:171","msg":"trace[56704119] transaction","detail":"{read_only:false; response_revision:20337; number_of_response:1; }","duration":"199.075378ms","start":"2026-06-12T03:54:57.359327Z","end":"2026-06-12T03:54:57.558403Z","steps":["trace[56704119] 'process raft request'  (duration: 198.894915ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:54:57.55848Z","caller":"traceutil/trace.go:171","msg":"trace[1034203008] transaction","detail":"{read_only:false; response_revision:20336; number_of_response:1; }","duration":"201.032784ms","start":"2026-06-12T03:54:57.357395Z","end":"2026-06-12T03:54:57.558427Z","steps":["trace[1034203008] 'process raft request'  (duration: 200.628417ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:55:08.315849Z","caller":"traceutil/trace.go:171","msg":"trace[1502077717] transaction","detail":"{read_only:false; response_revision:20412; number_of_response:1; }","duration":"106.262888ms","start":"2026-06-12T03:55:08.209534Z","end":"2026-06-12T03:55:08.315797Z","steps":["trace[1502077717] 'process raft request'  (duration: 106.019023ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:55:08.607427Z","caller":"traceutil/trace.go:171","msg":"trace[1561740820] transaction","detail":"{read_only:false; response_revision:20413; number_of_response:1; }","duration":"286.24938ms","start":"2026-06-12T03:55:08.321142Z","end":"2026-06-12T03:55:08.607391Z","steps":["trace[1561740820] 'process raft request'  (duration: 285.950064ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:55:08.60763Z","caller":"traceutil/trace.go:171","msg":"trace[655427452] transaction","detail":"{read_only:false; response_revision:20414; number_of_response:1; }","duration":"286.464815ms","start":"2026-06-12T03:55:08.321129Z","end":"2026-06-12T03:55:08.607594Z","steps":["trace[655427452] 'process raft request'  (duration: 286.194889ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T03:55:08.870185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.576046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T03:55:08.870254Z","caller":"traceutil/trace.go:171","msg":"trace[2034498139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20414; }","duration":"113.698059ms","start":"2026-06-12T03:55:08.75654Z","end":"2026-06-12T03:55:08.870238Z","steps":["trace[2034498139] 'range keys from in-memory index tree'  (duration: 113.503955ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:55:09.15706Z","caller":"traceutil/trace.go:171","msg":"trace[527494953] transaction","detail":"{read_only:false; response_revision:20416; number_of_response:1; }","duration":"202.88965ms","start":"2026-06-12T03:55:08.954138Z","end":"2026-06-12T03:55:09.157027Z","steps":["trace[527494953] 'process raft request'  (duration: 192.838899ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:55:09.157255Z","caller":"traceutil/trace.go:171","msg":"trace[152534563] transaction","detail":"{read_only:false; response_revision:20417; number_of_response:1; }","duration":"185.268144ms","start":"2026-06-12T03:55:08.971953Z","end":"2026-06-12T03:55:09.157221Z","steps":["trace[152534563] 'process raft request'  (duration: 184.946348ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:59:09.636525Z","caller":"traceutil/trace.go:171","msg":"trace[1938385867] transaction","detail":"{read_only:false; response_revision:22870; number_of_response:1; }","duration":"159.964285ms","start":"2026-06-12T03:59:09.476523Z","end":"2026-06-12T03:59:09.636488Z","steps":["trace[1938385867] 'process raft request'  (duration: 158.443726ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:59:09.644292Z","caller":"traceutil/trace.go:171","msg":"trace[1633095838] transaction","detail":"{read_only:false; response_revision:22871; number_of_response:1; }","duration":"112.49219ms","start":"2026-06-12T03:59:09.531759Z","end":"2026-06-12T03:59:09.644251Z","steps":["trace[1633095838] 'process raft request'  (duration: 112.327227ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T03:59:28.387063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20186}
{"level":"info","ts":"2026-06-12T03:59:28.496931Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20186,"took":"105.65162ms","hash":893238697,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":42172416,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-06-12T03:59:28.497027Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":893238697,"revision":20186,"compact-revision":17813}
{"level":"info","ts":"2026-06-12T04:02:53.056574Z","caller":"traceutil/trace.go:171","msg":"trace[518301091] transaction","detail":"{read_only:false; response_revision:25165; number_of_response:1; }","duration":"107.693899ms","start":"2026-06-12T04:02:52.94885Z","end":"2026-06-12T04:02:53.056543Z","steps":["trace[518301091] 'process raft request'  (duration: 107.439934ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:02:58.695605Z","caller":"traceutil/trace.go:171","msg":"trace[930018510] transaction","detail":"{read_only:false; response_revision:25213; number_of_response:1; }","duration":"152.529522ms","start":"2026-06-12T04:02:58.543051Z","end":"2026-06-12T04:02:58.695581Z","steps":["trace[930018510] 'process raft request'  (duration: 152.340379ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.186836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.080863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:02:59.186936Z","caller":"traceutil/trace.go:171","msg":"trace[1416353914] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:25214; }","duration":"123.222645ms","start":"2026-06-12T04:02:59.063679Z","end":"2026-06-12T04:02:59.186902Z","steps":["trace[1416353914] 'count revisions from in-memory index tree'  (duration: 122.97865ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:02:59.237929Z","caller":"traceutil/trace.go:171","msg":"trace[71906121] transaction","detail":"{read_only:false; response_revision:25215; number_of_response:1; }","duration":"157.11026ms","start":"2026-06-12T04:02:59.080793Z","end":"2026-06-12T04:02:59.237903Z","steps":["trace[71906121] 'process raft request'  (duration: 156.931956ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:02:59.401435Z","caller":"traceutil/trace.go:171","msg":"trace[1999056684] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"319.987559ms","start":"2026-06-12T04:02:59.081419Z","end":"2026-06-12T04:02:59.401407Z","steps":["trace[1999056684] 'process raft request'  (duration: 249.214902ms)","trace[1999056684] 'compare'  (duration: 70.611534ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:02:59.401584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.081402Z","time spent":"320.103872ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25202 > 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-06-12T04:02:59.401644Z","caller":"traceutil/trace.go:171","msg":"trace[585246072] linearizableReadLoop","detail":"{readStateIndex:26036; appliedIndex:26033; }","duration":"190.155579ms","start":"2026-06-12T04:02:59.211446Z","end":"2026-06-12T04:02:59.401602Z","steps":["trace[585246072] 'read index received'  (duration: 26.24794ms)","trace[585246072] 'applied index is now lower than readState.Index'  (duration: 163.906199ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:02:59.402008Z","caller":"traceutil/trace.go:171","msg":"trace[1994911038] transaction","detail":"{read_only:false; response_revision:25217; number_of_response:1; }","duration":"213.518143ms","start":"2026-06-12T04:02:59.1884Z","end":"2026-06-12T04:02:59.401919Z","steps":["trace[1994911038] 'process raft request'  (duration: 212.969103ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.402152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.677578ms","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-06-12T04:02:59.402258Z","caller":"traceutil/trace.go:171","msg":"trace[1787656144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25217; }","duration":"190.825661ms","start":"2026-06-12T04:02:59.211392Z","end":"2026-06-12T04:02:59.402218Z","steps":["trace[1787656144] 'agreement among raft nodes before linearized reading'  (duration: 190.530866ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:02:59.751779Z","caller":"traceutil/trace.go:171","msg":"trace[156744792] transaction","detail":"{read_only:false; response_revision:25218; number_of_response:1; }","duration":"359.647174ms","start":"2026-06-12T04:02:59.392113Z","end":"2026-06-12T04:02:59.75176Z","steps":["trace[156744792] 'process raft request'  (duration: 352.989198ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.751885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.392086Z","time spent":"359.740636ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25137 > 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-06-12T04:02:59.763335Z","caller":"traceutil/trace.go:171","msg":"trace[1854534272] linearizableReadLoop","detail":"{readStateIndex:26038; appliedIndex:26036; }","duration":"361.591141ms","start":"2026-06-12T04:02:59.401735Z","end":"2026-06-12T04:02:59.763327Z","steps":["trace[1854534272] 'read index received'  (duration: 343.382545ms)","trace[1854534272] 'applied index is now lower than readState.Index'  (duration: 18.208066ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:02:59.763414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.826538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-12T04:02:59.763433Z","caller":"traceutil/trace.go:171","msg":"trace[1728104831] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:25220; }","duration":"369.893719ms","start":"2026-06-12T04:02:59.393534Z","end":"2026-06-12T04:02:59.763428Z","steps":["trace[1728104831] 'agreement among raft nodes before linearized reading'  (duration: 369.843848ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.763452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.393514Z","time spent":"369.932989ms","remote":"127.0.0.1:54432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":7,"response size":31,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"info","ts":"2026-06-12T04:02:59.763467Z","caller":"traceutil/trace.go:171","msg":"trace[669886590] transaction","detail":"{read_only:false; response_revision:25220; number_of_response:1; }","duration":"356.368291ms","start":"2026-06-12T04:02:59.407034Z","end":"2026-06-12T04:02:59.763402Z","steps":["trace[669886590] 'process raft request'  (duration: 356.269239ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.763597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.051834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:02:59.763616Z","caller":"traceutil/trace.go:171","msg":"trace[672459203] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:25220; }","duration":"472.104335ms","start":"2026-06-12T04:02:59.291505Z","end":"2026-06-12T04:02:59.76361Z","steps":["trace[672459203] 'agreement among raft nodes before linearized reading'  (duration: 472.070185ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.763631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.291486Z","time spent":"472.140876ms","remote":"127.0.0.1:57786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:02:59.763695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.407006Z","time spent":"356.560946ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25204 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-06-12T04:02:59.76372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.377516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:02:59.763717Z","caller":"traceutil/trace.go:171","msg":"trace[1316895692] transaction","detail":"{read_only:false; response_revision:25219; number_of_response:1; }","duration":"368.391361ms","start":"2026-06-12T04:02:59.395241Z","end":"2026-06-12T04:02:59.763632Z","steps":["trace[1316895692] 'process raft request'  (duration: 368.008373ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:02:59.763819Z","caller":"traceutil/trace.go:171","msg":"trace[1041995143] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:25220; }","duration":"300.56078ms","start":"2026-06-12T04:02:59.463232Z","end":"2026-06-12T04:02:59.763793Z","steps":["trace[1041995143] 'agreement among raft nodes before linearized reading'  (duration: 300.334046ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:02:59.763876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.463212Z","time spent":"300.649271ms","remote":"127.0.0.1:57882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:02:59.763939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:02:59.395216Z","time spent":"368.604985ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25205 > 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-06-12T04:03:00.105471Z","caller":"traceutil/trace.go:171","msg":"trace[2026114049] transaction","detail":"{read_only:false; response_revision:25221; number_of_response:1; }","duration":"185.604822ms","start":"2026-06-12T04:02:59.919829Z","end":"2026-06-12T04:03:00.105433Z","steps":["trace[2026114049] 'process raft request'  (duration: 146.186692ms)","trace[2026114049] 'compare'  (duration: 39.207356ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:00.378884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.624281ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781713 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25209 > 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-06-12T04:03:00.379063Z","caller":"traceutil/trace.go:171","msg":"trace[1991757586] transaction","detail":"{read_only:false; response_revision:25222; number_of_response:1; }","duration":"268.768575ms","start":"2026-06-12T04:03:00.110273Z","end":"2026-06-12T04:03:00.379041Z","steps":["trace[1991757586] 'process raft request'  (duration: 142.889419ms)","trace[1991757586] 'compare'  (duration: 125.407177ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:00.423852Z","caller":"traceutil/trace.go:171","msg":"trace[118498025] linearizableReadLoop","detail":"{readStateIndex:26042; appliedIndex:26040; }","duration":"228.02227ms","start":"2026-06-12T04:03:00.195803Z","end":"2026-06-12T04:03:00.423826Z","steps":["trace[118498025] 'read index received'  (duration: 57.370892ms)","trace[118498025] 'applied index is now lower than readState.Index'  (duration: 170.650478ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:00.423976Z","caller":"traceutil/trace.go:171","msg":"trace[1578778839] transaction","detail":"{read_only:false; response_revision:25223; number_of_response:1; }","duration":"313.184441ms","start":"2026-06-12T04:03:00.110754Z","end":"2026-06-12T04:03:00.423939Z","steps":["trace[1578778839] 'process raft request'  (duration: 312.909636ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:00.424172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:00.110732Z","time spent":"313.304523ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25208 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:00.424167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.344566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-06-12T04:03:00.424226Z","caller":"traceutil/trace.go:171","msg":"trace[1337987425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25223; }","duration":"228.517989ms","start":"2026-06-12T04:03:00.195694Z","end":"2026-06-12T04:03:00.424212Z","steps":["trace[1337987425] 'agreement among raft nodes before linearized reading'  (duration: 228.286565ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:00.672765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.124916ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781715 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25212 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:00.673087Z","caller":"traceutil/trace.go:171","msg":"trace[1249538893] linearizableReadLoop","detail":"{readStateIndex:26043; appliedIndex:26042; }","duration":"249.119071ms","start":"2026-06-12T04:03:00.423941Z","end":"2026-06-12T04:03:00.67306Z","steps":["trace[1249538893] 'read index received'  (duration: 106.543567ms)","trace[1249538893] 'applied index is now lower than readState.Index'  (duration: 142.573814ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:00.673143Z","caller":"traceutil/trace.go:171","msg":"trace[669894565] transaction","detail":"{read_only:false; response_revision:25224; number_of_response:1; }","duration":"413.348936ms","start":"2026-06-12T04:03:00.259713Z","end":"2026-06-12T04:03:00.673062Z","steps":["trace[669894565] 'process raft request'  (duration: 270.787562ms)","trace[669894565] 'compare'  (duration: 141.929112ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:00.673223Z","caller":"traceutil/trace.go:171","msg":"trace[957962531] transaction","detail":"{read_only:false; response_revision:25225; number_of_response:1; }","duration":"244.049595ms","start":"2026-06-12T04:03:00.429161Z","end":"2026-06-12T04:03:00.67321Z","steps":["trace[957962531] 'process raft request'  (duration: 243.717098ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:00.673428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:00.259686Z","time spent":"413.582941ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25212 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-06-12T04:03:00.673562Z","caller":"traceutil/trace.go:171","msg":"trace[1162603297] transaction","detail":"{read_only:false; response_revision:25226; number_of_response:1; }","duration":"146.017489ms","start":"2026-06-12T04:03:00.527526Z","end":"2026-06-12T04:03:00.673543Z","steps":["trace[1162603297] 'process raft request'  (duration: 145.577491ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:00.674224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.811993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-06-12T04:03:00.674267Z","caller":"traceutil/trace.go:171","msg":"trace[526024335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25226; }","duration":"477.892144ms","start":"2026-06-12T04:03:00.196366Z","end":"2026-06-12T04:03:00.674258Z","steps":["trace[526024335] 'agreement among raft nodes before linearized reading'  (duration: 476.771372ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:00.674495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:00.196352Z","time spent":"478.069607ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-06-12T04:03:01.040488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.939331ms","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-06-12T04:03:01.040656Z","caller":"traceutil/trace.go:171","msg":"trace[530780437] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25227; }","duration":"132.142085ms","start":"2026-06-12T04:03:00.908493Z","end":"2026-06-12T04:03:01.040635Z","steps":["trace[530780437] 'range keys from in-memory index tree'  (duration: 131.91236ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:01.041193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.725338ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781721 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25213 > 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-06-12T04:03:01.04129Z","caller":"traceutil/trace.go:171","msg":"trace[1081875640] linearizableReadLoop","detail":"{readStateIndex:26047; appliedIndex:26046; }","duration":"284.488274ms","start":"2026-06-12T04:03:00.756785Z","end":"2026-06-12T04:03:01.041274Z","steps":["trace[1081875640] 'read index received'  (duration: 102.50136ms)","trace[1081875640] 'applied index is now lower than readState.Index'  (duration: 181.985324ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:01.041404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.614036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:01.041454Z","caller":"traceutil/trace.go:171","msg":"trace[1650017873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25228; }","duration":"284.696288ms","start":"2026-06-12T04:03:00.756744Z","end":"2026-06-12T04:03:01.04144Z","steps":["trace[1650017873] 'agreement among raft nodes before linearized reading'  (duration: 284.583376ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:01.041421Z","caller":"traceutil/trace.go:171","msg":"trace[1145967028] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"340.939688ms","start":"2026-06-12T04:03:00.70043Z","end":"2026-06-12T04:03:01.04137Z","steps":["trace[1145967028] 'process raft request'  (duration: 158.926774ms)","trace[1145967028] 'compare'  (duration: 181.551985ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:01.041625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:00.7004Z","time spent":"341.111381ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25213 > 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-06-12T04:03:01.290816Z","caller":"traceutil/trace.go:171","msg":"trace[2074748791] linearizableReadLoop","detail":"{readStateIndex:26048; appliedIndex:26047; }","duration":"248.087111ms","start":"2026-06-12T04:03:01.0427Z","end":"2026-06-12T04:03:01.290787Z","steps":["trace[2074748791] 'read index received'  (duration: 242.140408ms)","trace[2074748791] 'applied index is now lower than readState.Index'  (duration: 5.945433ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:01.290919Z","caller":"traceutil/trace.go:171","msg":"trace[1756216747] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"393.999697ms","start":"2026-06-12T04:03:00.896874Z","end":"2026-06-12T04:03:01.290874Z","steps":["trace[1756216747] 'process raft request'  (duration: 388.020374ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:01.290974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.255874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:01.29101Z","caller":"traceutil/trace.go:171","msg":"trace[1915767963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25229; }","duration":"248.348126ms","start":"2026-06-12T04:03:01.042652Z","end":"2026-06-12T04:03:01.291Z","steps":["trace[1915767963] 'agreement among raft nodes before linearized reading'  (duration: 248.235624ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:01.291107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:00.89685Z","time spent":"394.1501ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25214 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:01.605858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.707953ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781726 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:25217 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:01.606085Z","caller":"traceutil/trace.go:171","msg":"trace[1231833793] linearizableReadLoop","detail":"{readStateIndex:26051; appliedIndex:26049; }","duration":"157.122989ms","start":"2026-06-12T04:03:01.448945Z","end":"2026-06-12T04:03:01.606068Z","steps":["trace[1231833793] 'read index received'  (duration: 22.06702ms)","trace[1231833793] 'applied index is now lower than readState.Index'  (duration: 135.054969ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:01.606253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.316045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-06-12T04:03:01.606524Z","caller":"traceutil/trace.go:171","msg":"trace[826923618] transaction","detail":"{read_only:false; response_revision:25232; number_of_response:1; }","duration":"199.17679ms","start":"2026-06-12T04:03:01.407328Z","end":"2026-06-12T04:03:01.606504Z","steps":["trace[826923618] 'process raft request'  (duration: 198.64386ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:01.606361Z","caller":"traceutil/trace.go:171","msg":"trace[614882235] transaction","detail":"{read_only:false; response_revision:25231; number_of_response:1; }","duration":"199.280643ms","start":"2026-06-12T04:03:01.407045Z","end":"2026-06-12T04:03:01.606325Z","steps":["trace[614882235] 'process raft request'  (duration: 63.998148ms)","trace[614882235] 'compare'  (duration: 133.917199ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:01.606324Z","caller":"traceutil/trace.go:171","msg":"trace[965881645] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:25232; }","duration":"157.423666ms","start":"2026-06-12T04:03:01.448887Z","end":"2026-06-12T04:03:01.606311Z","steps":["trace[965881645] 'agreement among raft nodes before linearized reading'  (duration: 157.229711ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:01.812136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.533299ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781730 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:54ce9eb9d2e99e61>","response":"size:41"}
{"level":"info","ts":"2026-06-12T04:03:01.81228Z","caller":"traceutil/trace.go:171","msg":"trace[1353860530] linearizableReadLoop","detail":"{readStateIndex:26052; appliedIndex:26051; }","duration":"121.588064ms","start":"2026-06-12T04:03:01.690671Z","end":"2026-06-12T04:03:01.812259Z","steps":["trace[1353860530] 'read index received'  (duration: 16.850321ms)","trace[1353860530] 'applied index is now lower than readState.Index'  (duration: 104.735923ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:01.8125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.813898ms","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-06-12T04:03:01.812585Z","caller":"traceutil/trace.go:171","msg":"trace[224380890] 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:25232; }","duration":"121.949141ms","start":"2026-06-12T04:03:01.690613Z","end":"2026-06-12T04:03:01.812562Z","steps":["trace[224380890] 'agreement among raft nodes before linearized reading'  (duration: 121.766967ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:02.099608Z","caller":"traceutil/trace.go:171","msg":"trace[2133322406] transaction","detail":"{read_only:false; response_revision:25233; number_of_response:1; }","duration":"330.718534ms","start":"2026-06-12T04:03:01.768851Z","end":"2026-06-12T04:03:02.09957Z","steps":["trace[2133322406] 'process raft request'  (duration: 241.899813ms)","trace[2133322406] 'compare'  (duration: 88.606897ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:02.099602Z","caller":"traceutil/trace.go:171","msg":"trace[1631627526] linearizableReadLoop","detail":"{readStateIndex:26053; appliedIndex:26052; }","duration":"287.234886ms","start":"2026-06-12T04:03:01.812323Z","end":"2026-06-12T04:03:02.099558Z","steps":["trace[1631627526] 'read index received'  (duration: 198.62656ms)","trace[1631627526] 'applied index is now lower than readState.Index'  (duration: 88.606856ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:02.099778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:01.768827Z","time spent":"330.846005ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25219 > 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-06-12T04:03:02.099929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.625479ms","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-06-12T04:03:02.100294Z","caller":"traceutil/trace.go:171","msg":"trace[233899688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25233; }","duration":"332.742092ms","start":"2026-06-12T04:03:01.767235Z","end":"2026-06-12T04:03:02.099977Z","steps":["trace[233899688] 'agreement among raft nodes before linearized reading'  (duration: 332.486597ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.100374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:01.767216Z","time spent":"333.139029ms","remote":"127.0.0.1:54452","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-06-12T04:03:02.112448Z","caller":"traceutil/trace.go:171","msg":"trace[1871274320] transaction","detail":"{read_only:false; response_revision:25234; number_of_response:1; }","duration":"299.258256ms","start":"2026-06-12T04:03:01.813148Z","end":"2026-06-12T04:03:02.112406Z","steps":["trace[1871274320] 'process raft request'  (duration: 299.095333ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.112483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.922745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-12T04:03:02.112478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.236159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:02.112518Z","caller":"traceutil/trace.go:171","msg":"trace[1198020448] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:25234; }","duration":"116.992946ms","start":"2026-06-12T04:03:01.995514Z","end":"2026-06-12T04:03:02.112507Z","steps":["trace[1198020448] 'agreement among raft nodes before linearized reading'  (duration: 116.864153ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:02.112547Z","caller":"traceutil/trace.go:171","msg":"trace[485657818] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25234; }","duration":"295.30986ms","start":"2026-06-12T04:03:01.817217Z","end":"2026-06-12T04:03:02.112526Z","steps":["trace[485657818] 'agreement among raft nodes before linearized reading'  (duration: 295.156977ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.112703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.957987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:02.112763Z","caller":"traceutil/trace.go:171","msg":"trace[1084448759] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:25234; }","duration":"125.161501ms","start":"2026-06-12T04:03:01.987587Z","end":"2026-06-12T04:03:02.112749Z","steps":["trace[1084448759] 'agreement among raft nodes before linearized reading'  (duration: 124.921397ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.378369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.237962ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781735 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25220 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:02.378573Z","caller":"traceutil/trace.go:171","msg":"trace[2050200325] linearizableReadLoop","detail":"{readStateIndex:26056; appliedIndex:26054; }","duration":"263.514354ms","start":"2026-06-12T04:03:02.115039Z","end":"2026-06-12T04:03:02.378553Z","steps":["trace[2050200325] 'read index received'  (duration: 127.034927ms)","trace[2050200325] 'applied index is now lower than readState.Index'  (duration: 136.478357ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:02.378591Z","caller":"traceutil/trace.go:171","msg":"trace[1697852295] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"274.014785ms","start":"2026-06-12T04:03:02.104537Z","end":"2026-06-12T04:03:02.378552Z","steps":["trace[1697852295] 'process raft request'  (duration: 137.475897ms)","trace[1697852295] 'compare'  (duration: 136.135821ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:02.378672Z","caller":"traceutil/trace.go:171","msg":"trace[46705279] transaction","detail":"{read_only:false; response_revision:25236; number_of_response:1; }","duration":"268.594251ms","start":"2026-06-12T04:03:02.110066Z","end":"2026-06-12T04:03:02.378661Z","steps":["trace[46705279] 'process raft request'  (duration: 268.408638ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.378757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.501727ms","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-06-12T04:03:02.378857Z","caller":"traceutil/trace.go:171","msg":"trace[1928539575] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25236; }","duration":"260.64036ms","start":"2026-06-12T04:03:02.118191Z","end":"2026-06-12T04:03:02.378831Z","steps":["trace[1928539575] 'agreement among raft nodes before linearized reading'  (duration: 260.484357ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.378902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.85898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"}
{"level":"info","ts":"2026-06-12T04:03:02.378939Z","caller":"traceutil/trace.go:171","msg":"trace[1401896677] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25236; }","duration":"263.929932ms","start":"2026-06-12T04:03:02.114999Z","end":"2026-06-12T04:03:02.378929Z","steps":["trace[1401896677] 'agreement among raft nodes before linearized reading'  (duration: 263.79363ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.696037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.189493ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781747 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25223 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:02.696167Z","caller":"traceutil/trace.go:171","msg":"trace[2065384315] linearizableReadLoop","detail":"{readStateIndex:26058; appliedIndex:26057; }","duration":"242.496554ms","start":"2026-06-12T04:03:02.453651Z","end":"2026-06-12T04:03:02.696147Z","steps":["trace[2065384315] 'read index received'  (duration: 108.095347ms)","trace[2065384315] 'applied index is now lower than readState.Index'  (duration: 134.399667ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:02.69652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:02.696632Z","caller":"traceutil/trace.go:171","msg":"trace[1609879933] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25238; }","duration":"242.996504ms","start":"2026-06-12T04:03:02.453613Z","end":"2026-06-12T04:03:02.696609Z","steps":["trace[1609879933] 'agreement among raft nodes before linearized reading'  (duration: 242.78843ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:02.696958Z","caller":"traceutil/trace.go:171","msg":"trace[104762347] transaction","detail":"{read_only:false; response_revision:25238; number_of_response:1; }","duration":"263.009216ms","start":"2026-06-12T04:03:02.433921Z","end":"2026-06-12T04:03:02.69693Z","steps":["trace[104762347] 'process raft request'  (duration: 127.829173ms)","trace[104762347] 'compare'  (duration: 134.067251ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:02.997084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.233864ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781748 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25224 > 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-06-12T04:03:02.997203Z","caller":"traceutil/trace.go:171","msg":"trace[1208261289] linearizableReadLoop","detail":"{readStateIndex:26059; appliedIndex:26058; }","duration":"300.992318ms","start":"2026-06-12T04:03:02.696194Z","end":"2026-06-12T04:03:02.997186Z","steps":["trace[1208261289] 'read index received'  (duration: 156.629761ms)","trace[1208261289] 'applied index is now lower than readState.Index'  (duration: 144.361267ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:02.997263Z","caller":"traceutil/trace.go:171","msg":"trace[1133147527] transaction","detail":"{read_only:false; response_revision:25239; number_of_response:1; }","duration":"317.38229ms","start":"2026-06-12T04:03:02.679846Z","end":"2026-06-12T04:03:02.997228Z","steps":["trace[1133147527] 'process raft request'  (duration: 172.909661ms)","trace[1133147527] 'compare'  (duration: 143.95967ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:02.997407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.557703ms","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-06-12T04:03:02.9974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.570243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:02.997441Z","caller":"traceutil/trace.go:171","msg":"trace[2047233707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25239; }","duration":"317.629535ms","start":"2026-06-12T04:03:02.679801Z","end":"2026-06-12T04:03:02.99743Z","steps":["trace[2047233707] 'agreement among raft nodes before linearized reading'  (duration: 317.474152ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.997483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:02.679774Z","time spent":"317.700876ms","remote":"127.0.0.1:54452","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-06-12T04:03:02.997477Z","caller":"traceutil/trace.go:171","msg":"trace[1635531347] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:25239; }","duration":"287.692804ms","start":"2026-06-12T04:03:02.709761Z","end":"2026-06-12T04:03:02.997454Z","steps":["trace[1635531347] 'agreement among raft nodes before linearized reading'  (duration: 287.569192ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.997692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.6781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:02.997734Z","caller":"traceutil/trace.go:171","msg":"trace[1592359284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25239; }","duration":"240.757532ms","start":"2026-06-12T04:03:02.756964Z","end":"2026-06-12T04:03:02.997721Z","steps":["trace[1592359284] 'agreement among raft nodes before linearized reading'  (duration: 240.703351ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.99785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.615307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:02.997943Z","caller":"traceutil/trace.go:171","msg":"trace[1515097028] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:25239; }","duration":"272.794482ms","start":"2026-06-12T04:03:02.725127Z","end":"2026-06-12T04:03:02.997921Z","steps":["trace[1515097028] 'agreement among raft nodes before linearized reading'  (duration: 272.603347ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.997974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.956396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-06-12T04:03:02.998004Z","caller":"traceutil/trace.go:171","msg":"trace[1154637032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25239; }","duration":"271.032188ms","start":"2026-06-12T04:03:02.726963Z","end":"2026-06-12T04:03:02.997996Z","steps":["trace[1154637032] 'agreement among raft nodes before linearized reading'  (duration: 270.901966ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:02.998045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:02.67982Z","time spent":"317.524963ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25224 > 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-06-12T04:03:03.355241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.652682ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781755 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25228 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:03.355383Z","caller":"traceutil/trace.go:171","msg":"trace[1975019721] transaction","detail":"{read_only:false; response_revision:25242; number_of_response:1; }","duration":"307.762027ms","start":"2026-06-12T04:03:03.047593Z","end":"2026-06-12T04:03:03.355355Z","steps":["trace[1975019721] 'process raft request'  (duration: 68.879521ms)","trace[1975019721] 'compare'  (duration: 238.273094ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:03.355477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:03.047576Z","time spent":"307.850248ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25228 > 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-06-12T04:03:03.978891Z","caller":"traceutil/trace.go:171","msg":"trace[1568935219] transaction","detail":"{read_only:false; response_revision:25245; number_of_response:1; }","duration":"424.372965ms","start":"2026-06-12T04:03:03.554496Z","end":"2026-06-12T04:03:03.978869Z","steps":["trace[1568935219] 'process raft request'  (duration: 424.206642ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:03.979029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:03.554471Z","time spent":"424.482178ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25195 > 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-06-12T04:03:04.203277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.02843ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781768 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:25231 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:04.20358Z","caller":"traceutil/trace.go:171","msg":"trace[993755529] transaction","detail":"{read_only:false; response_revision:25248; number_of_response:1; }","duration":"131.973012ms","start":"2026-06-12T04:03:04.071583Z","end":"2026-06-12T04:03:04.203556Z","steps":["trace[993755529] 'process raft request'  (duration: 131.916821ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:04.203636Z","caller":"traceutil/trace.go:171","msg":"trace[1795088740] transaction","detail":"{read_only:false; response_revision:25246; number_of_response:1; }","duration":"592.457755ms","start":"2026-06-12T04:03:03.611153Z","end":"2026-06-12T04:03:04.20361Z","steps":["trace[1795088740] 'process raft request'  (duration: 405.978985ms)","trace[1795088740] 'compare'  (duration: 184.134405ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:04.203753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:03.611134Z","time spent":"592.549016ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25231 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-06-12T04:03:04.203805Z","caller":"traceutil/trace.go:171","msg":"trace[1736253006] linearizableReadLoop","detail":"{readStateIndex:26067; appliedIndex:26064; }","duration":"446.303163ms","start":"2026-06-12T04:03:03.757475Z","end":"2026-06-12T04:03:04.203778Z","steps":["trace[1736253006] 'read index received'  (duration: 221.298161ms)","trace[1736253006] 'applied index is now lower than readState.Index'  (duration: 225.003872ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:04.203835Z","caller":"traceutil/trace.go:171","msg":"trace[1789648569] transaction","detail":"{read_only:false; response_revision:25247; number_of_response:1; }","duration":"592.688899ms","start":"2026-06-12T04:03:03.61114Z","end":"2026-06-12T04:03:04.203829Z","steps":["trace[1789648569] 'process raft request'  (duration: 592.254681ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.203858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:03.611108Z","time spent":"592.73628ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25232 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:04.203926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.450586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:04.203948Z","caller":"traceutil/trace.go:171","msg":"trace[2104730887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25248; }","duration":"446.506407ms","start":"2026-06-12T04:03:03.757436Z","end":"2026-06-12T04:03:04.203942Z","steps":["trace[2104730887] 'agreement among raft nodes before linearized reading'  (duration: 446.408215ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.203963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:03.757418Z","time spent":"446.540827ms","remote":"127.0.0.1:54150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-06-12T04:03:04.473298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.174651ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781770 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25233 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:04.473422Z","caller":"traceutil/trace.go:171","msg":"trace[576799384] linearizableReadLoop","detail":"{readStateIndex:26069; appliedIndex:26068; }","duration":"269.563379ms","start":"2026-06-12T04:03:04.203826Z","end":"2026-06-12T04:03:04.473389Z","steps":["trace[576799384] 'read index received'  (duration: 144.117372ms)","trace[576799384] 'applied index is now lower than readState.Index'  (duration: 125.444877ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:04.473498Z","caller":"traceutil/trace.go:171","msg":"trace[293275890] transaction","detail":"{read_only:false; response_revision:25249; number_of_response:1; }","duration":"368.835559ms","start":"2026-06-12T04:03:04.10465Z","end":"2026-06-12T04:03:04.473486Z","steps":["trace[293275890] 'process raft request'  (duration: 243.384652ms)","trace[293275890] 'compare'  (duration: 125.06307ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:04.473565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.104631Z","time spent":"368.90164ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25233 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:04.473891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.703335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-12T04:03:04.473954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.697336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-06-12T04:03:04.47401Z","caller":"traceutil/trace.go:171","msg":"trace[988740667] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:25249; }","duration":"514.929269ms","start":"2026-06-12T04:03:03.959053Z","end":"2026-06-12T04:03:04.473982Z","steps":["trace[988740667] 'agreement among raft nodes before linearized reading'  (duration: 514.605143ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:04.474065Z","caller":"traceutil/trace.go:171","msg":"trace[1471534817] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25249; }","duration":"420.806728ms","start":"2026-06-12T04:03:04.053187Z","end":"2026-06-12T04:03:04.473994Z","steps":["trace[1471534817] 'agreement among raft nodes before linearized reading'  (duration: 420.502032ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.474074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:03.95903Z","time spent":"515.024461ms","remote":"127.0.0.1:57486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:04.474143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.05317Z","time spent":"420.96052ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":584,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-06-12T04:03:04.956713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.90631ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781772 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25236 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:04.956868Z","caller":"traceutil/trace.go:171","msg":"trace[583155506] transaction","detail":"{read_only:false; response_revision:25250; number_of_response:1; }","duration":"572.833541ms","start":"2026-06-12T04:03:04.383999Z","end":"2026-06-12T04:03:04.956833Z","steps":["trace[583155506] 'process raft request'  (duration: 399.698896ms)","trace[583155506] 'compare'  (duration: 172.732146ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:04.956951Z","caller":"traceutil/trace.go:171","msg":"trace[840109712] transaction","detail":"{read_only:false; response_revision:25251; number_of_response:1; }","duration":"477.819264ms","start":"2026-06-12T04:03:04.47911Z","end":"2026-06-12T04:03:04.956929Z","steps":["trace[840109712] 'process raft request'  (duration: 477.732642ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:04.956963Z","caller":"traceutil/trace.go:171","msg":"trace[536345490] linearizableReadLoop","detail":"{readStateIndex:26070; appliedIndex:26069; }","duration":"483.479782ms","start":"2026-06-12T04:03:04.473452Z","end":"2026-06-12T04:03:04.956932Z","steps":["trace[536345490] 'read index received'  (duration: 310.160643ms)","trace[536345490] 'applied index is now lower than readState.Index'  (duration: 173.316239ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:04.957423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.479082Z","time spent":"478.291493ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:25136 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:04.957111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.4654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:04.957533Z","caller":"traceutil/trace.go:171","msg":"trace[312299333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25251; }","duration":"752.920118ms","start":"2026-06-12T04:03:04.204596Z","end":"2026-06-12T04:03:04.957516Z","steps":["trace[312299333] 'agreement among raft nodes before linearized reading'  (duration: 752.43954ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.957589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.204584Z","time spent":"752.991169ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-06-12T04:03:04.957132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.60216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-06-12T04:03:04.9578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.921796ms","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-06-12T04:03:04.957846Z","caller":"traceutil/trace.go:171","msg":"trace[1574527476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25251; }","duration":"248.998717ms","start":"2026-06-12T04:03:04.708836Z","end":"2026-06-12T04:03:04.957835Z","steps":["trace[1574527476] 'agreement among raft nodes before linearized reading'  (duration: 248.872965ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:04.957811Z","caller":"traceutil/trace.go:171","msg":"trace[1929533615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25251; }","duration":"550.352034ms","start":"2026-06-12T04:03:04.407448Z","end":"2026-06-12T04:03:04.9578Z","steps":["trace[1929533615] 'agreement among raft nodes before linearized reading'  (duration: 549.546609ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.958045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.407422Z","time spent":"550.600238ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-06-12T04:03:04.957168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.151109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-06-12T04:03:04.958185Z","caller":"traceutil/trace.go:171","msg":"trace[303617540] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:25251; }","duration":"490.163528ms","start":"2026-06-12T04:03:04.467996Z","end":"2026-06-12T04:03:04.95816Z","steps":["trace[303617540] 'agreement among raft nodes before linearized reading'  (duration: 489.011026ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.957183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.217754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-12T04:03:04.95719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.945472ms","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-06-12T04:03:04.957177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.721066ms","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-06-12T04:03:04.958303Z","caller":"traceutil/trace.go:171","msg":"trace[2026324008] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:25251; }","duration":"538.342785ms","start":"2026-06-12T04:03:04.419917Z","end":"2026-06-12T04:03:04.958259Z","steps":["trace[2026324008] 'agreement among raft nodes before linearized reading'  (duration: 537.239144ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:04.958299Z","caller":"traceutil/trace.go:171","msg":"trace[796226566] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:25251; }","duration":"710.861758ms","start":"2026-06-12T04:03:04.247399Z","end":"2026-06-12T04:03:04.958261Z","steps":["trace[796226566] 'agreement among raft nodes before linearized reading'  (duration: 709.737886ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.958358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.419894Z","time spent":"538.448077ms","remote":"127.0.0.1:57810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:04.958377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.247376Z","time spent":"710.97862ms","remote":"127.0.0.1:53174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":2,"response size":31,"request content":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true "}
{"level":"info","ts":"2026-06-12T04:03:04.958392Z","caller":"traceutil/trace.go:171","msg":"trace[903860220] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25251; }","duration":"576.198675ms","start":"2026-06-12T04:03:04.382179Z","end":"2026-06-12T04:03:04.958378Z","steps":["trace[903860220] 'agreement among raft nodes before linearized reading'  (duration: 574.89293ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:04.95844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.382159Z","time spent":"576.265217ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-06-12T04:03:04.95853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.467917Z","time spent":"490.582976ms","remote":"127.0.0.1:54206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":141,"response size":32,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:04.959604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.383971Z","time spent":"573.305571ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25236 > 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-06-12T04:03:05.288512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.869102ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781777 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25238 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:05.288602Z","caller":"traceutil/trace.go:171","msg":"trace[980565229] transaction","detail":"{read_only:false; response_revision:25252; number_of_response:1; }","duration":"325.984634ms","start":"2026-06-12T04:03:04.962601Z","end":"2026-06-12T04:03:05.288586Z","steps":["trace[980565229] 'process raft request'  (duration: 175.949298ms)","trace[980565229] 'compare'  (duration: 149.75676ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:05.28865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.962582Z","time spent":"326.046705ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25238 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-06-12T04:03:05.366005Z","caller":"traceutil/trace.go:171","msg":"trace[602217813] transaction","detail":"{read_only:false; response_revision:25253; number_of_response:1; }","duration":"401.946629ms","start":"2026-06-12T04:03:04.964018Z","end":"2026-06-12T04:03:05.365964Z","steps":["trace[602217813] 'process raft request'  (duration: 401.590833ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:05.366038Z","caller":"traceutil/trace.go:171","msg":"trace[670970439] transaction","detail":"{read_only:false; response_revision:25254; number_of_response:1; }","duration":"401.858488ms","start":"2026-06-12T04:03:04.964136Z","end":"2026-06-12T04:03:05.365995Z","steps":["trace[670970439] 'process raft request'  (duration: 401.677915ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:05.366133Z","caller":"traceutil/trace.go:171","msg":"trace[1579658816] transaction","detail":"{read_only:false; response_revision:25255; number_of_response:1; }","duration":"401.936459ms","start":"2026-06-12T04:03:04.964162Z","end":"2026-06-12T04:03:05.366098Z","steps":["trace[1579658816] 'process raft request'  (duration: 401.725515ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:05.366194Z","caller":"traceutil/trace.go:171","msg":"trace[1539890008] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"362.513798ms","start":"2026-06-12T04:03:05.003658Z","end":"2026-06-12T04:03:05.366172Z","steps":["trace[1539890008] 'process raft request'  (duration: 362.313385ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:05.366203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.963996Z","time spent":"402.101442ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25235 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:05.366304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.964135Z","time spent":"402.069832ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25237 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:05.366317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.011891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:05.366351Z","caller":"traceutil/trace.go:171","msg":"trace[910345941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25256; }","duration":"401.085792ms","start":"2026-06-12T04:03:04.965257Z","end":"2026-06-12T04:03:05.366343Z","steps":["trace[910345941] 'agreement among raft nodes before linearized reading'  (duration: 400.97883ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:05.366375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.965239Z","time spent":"401.131203ms","remote":"127.0.0.1:54150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-06-12T04:03:05.366327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:05.003636Z","time spent":"362.611411ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25239 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:05.366998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:04.964117Z","time spent":"401.98696ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:25142 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-06-12T04:03:05.367285Z","caller":"traceutil/trace.go:171","msg":"trace[868210336] linearizableReadLoop","detail":"{readStateIndex:26075; appliedIndex:26071; }","duration":"400.787957ms","start":"2026-06-12T04:03:04.965297Z","end":"2026-06-12T04:03:05.366085Z","steps":["trace[868210336] 'read index received'  (duration: 173.247896ms)","trace[868210336] 'applied index is now lower than readState.Index'  (duration: 227.538631ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:05.390806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.734722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-06-12T04:03:05.39083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.513039ms","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-06-12T04:03:05.390898Z","caller":"traceutil/trace.go:171","msg":"trace[407237677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25259; }","duration":"330.614332ms","start":"2026-06-12T04:03:05.060267Z","end":"2026-06-12T04:03:05.390882Z","steps":["trace[407237677] 'agreement among raft nodes before linearized reading'  (duration: 330.433629ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:05.390932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:05.060257Z","time spent":"330.666833ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-06-12T04:03:05.390861Z","caller":"traceutil/trace.go:171","msg":"trace[675697976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25259; }","duration":"342.840884ms","start":"2026-06-12T04:03:05.048008Z","end":"2026-06-12T04:03:05.390849Z","steps":["trace[675697976] 'agreement among raft nodes before linearized reading'  (duration: 342.697992ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:05.391063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:05.047985Z","time spent":"343.069739ms","remote":"127.0.0.1:54452","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-06-12T04:03:12.474759Z","caller":"traceutil/trace.go:171","msg":"trace[138401882] transaction","detail":"{read_only:false; response_revision:25306; number_of_response:1; }","duration":"242.409683ms","start":"2026-06-12T04:03:12.23232Z","end":"2026-06-12T04:03:12.47473Z","steps":["trace[138401882] 'process raft request'  (duration: 242.185599ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.918659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.780062ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781887 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25291 > 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-06-12T04:03:12.918855Z","caller":"traceutil/trace.go:171","msg":"trace[763436291] transaction","detail":"{read_only:false; response_revision:25308; number_of_response:1; }","duration":"419.283399ms","start":"2026-06-12T04:03:12.499553Z","end":"2026-06-12T04:03:12.918836Z","steps":["trace[763436291] 'process raft request'  (duration: 419.212257ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.918935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.499527Z","time spent":"419.37039ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25292 > 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-06-12T04:03:12.919261Z","caller":"traceutil/trace.go:171","msg":"trace[827614966] linearizableReadLoop","detail":"{readStateIndex:26129; appliedIndex:26127; }","duration":"631.370205ms","start":"2026-06-12T04:03:12.287862Z","end":"2026-06-12T04:03:12.919232Z","steps":["trace[827614966] 'read index received'  (duration: 186.714853ms)","trace[827614966] 'applied index is now lower than readState.Index'  (duration: 444.652342ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:12.919373Z","caller":"traceutil/trace.go:171","msg":"trace[423896929] transaction","detail":"{read_only:false; response_revision:25307; number_of_response:1; }","duration":"684.604448ms","start":"2026-06-12T04:03:12.234732Z","end":"2026-06-12T04:03:12.919337Z","steps":["trace[423896929] 'process raft request'  (duration: 453.057821ms)","trace[423896929] 'compare'  (duration: 229.942366ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:12.91961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.86945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-12T04:03:12.919511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.599527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:12.919799Z","caller":"traceutil/trace.go:171","msg":"trace[1666007713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25308; }","duration":"160.903572ms","start":"2026-06-12T04:03:12.758864Z","end":"2026-06-12T04:03:12.919768Z","steps":["trace[1666007713] 'agreement among raft nodes before linearized reading'  (duration: 160.607506ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.91961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.609624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-12T04:03:12.919666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.513764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:12.919875Z","caller":"traceutil/trace.go:171","msg":"trace[1764803794] 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:25308; }","duration":"524.926049ms","start":"2026-06-12T04:03:12.394934Z","end":"2026-06-12T04:03:12.91986Z","steps":["trace[1764803794] 'agreement among raft nodes before linearized reading'  (duration: 524.579743ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.920162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.394923Z","time spent":"525.200514ms","remote":"127.0.0.1:38316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-06-12T04:03:12.91958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.683755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:12.920287Z","caller":"traceutil/trace.go:171","msg":"trace[603083198] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:25308; }","duration":"134.442529ms","start":"2026-06-12T04:03:12.785826Z","end":"2026-06-12T04:03:12.920269Z","steps":["trace[603083198] 'agreement among raft nodes before linearized reading'  (duration: 133.651134ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.91972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.234713Z","time spent":"684.941165ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25291 > 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-06-12T04:03:12.919724Z","caller":"traceutil/trace.go:171","msg":"trace[1334656031] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:25308; }","duration":"431.034273ms","start":"2026-06-12T04:03:12.488661Z","end":"2026-06-12T04:03:12.919695Z","steps":["trace[1334656031] 'agreement among raft nodes before linearized reading'  (duration: 430.82784ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.920585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.488644Z","time spent":"431.920179ms","remote":"127.0.0.1:47206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:12.919491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.589629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-12T04:03:12.920797Z","caller":"traceutil/trace.go:171","msg":"trace[746199288] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:25308; }","duration":"632.955385ms","start":"2026-06-12T04:03:12.287824Z","end":"2026-06-12T04:03:12.92078Z","steps":["trace[746199288] 'agreement among raft nodes before linearized reading'  (duration: 631.538268ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.920843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.287806Z","time spent":"633.025106ms","remote":"127.0.0.1:55606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":31,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "}
{"level":"info","ts":"2026-06-12T04:03:12.920135Z","caller":"traceutil/trace.go:171","msg":"trace[1190966896] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:25308; }","duration":"573.886201ms","start":"2026-06-12T04:03:12.346076Z","end":"2026-06-12T04:03:12.919962Z","steps":["trace[1190966896] 'agreement among raft nodes before linearized reading'  (duration: 573.459463ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:12.921892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.346057Z","time spent":"575.812447ms","remote":"127.0.0.1:38270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:13.502524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.848369ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781895 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25294 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:13.502786Z","caller":"traceutil/trace.go:171","msg":"trace[1540422339] transaction","detail":"{read_only:false; response_revision:25309; number_of_response:1; }","duration":"516.594781ms","start":"2026-06-12T04:03:12.986164Z","end":"2026-06-12T04:03:13.502759Z","steps":["trace[1540422339] 'process raft request'  (duration: 301.372996ms)","trace[1540422339] 'compare'  (duration: 213.556573ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:13.503204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:12.986134Z","time spent":"516.750964ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25294 > 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-06-12T04:03:13.503437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.505995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-06-12T04:03:13.503494Z","caller":"traceutil/trace.go:171","msg":"trace[157449853] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:25309; }","duration":"490.566256ms","start":"2026-06-12T04:03:13.012914Z","end":"2026-06-12T04:03:13.50348Z","steps":["trace[157449853] 'agreement among raft nodes before linearized reading'  (duration: 490.405213ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:13.503534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.01286Z","time spent":"490.661468ms","remote":"127.0.0.1:54320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":1589,"request content":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" "}
{"level":"info","ts":"2026-06-12T04:03:13.503618Z","caller":"traceutil/trace.go:171","msg":"trace[352662422] linearizableReadLoop","detail":"{readStateIndex:26131; appliedIndex:26130; }","duration":"489.75543ms","start":"2026-06-12T04:03:13.012922Z","end":"2026-06-12T04:03:13.502678Z","steps":["trace[352662422] 'read index received'  (duration: 274.553145ms)","trace[352662422] 'applied index is now lower than readState.Index'  (duration: 215.200455ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:14.017417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.12341ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187781896 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25296 > 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-06-12T04:03:14.017908Z","caller":"traceutil/trace.go:171","msg":"trace[1420728139] linearizableReadLoop","detail":"{readStateIndex:26135; appliedIndex:26131; }","duration":"514.152624ms","start":"2026-06-12T04:03:13.503731Z","end":"2026-06-12T04:03:14.017884Z","steps":["trace[1420728139] 'read index received'  (duration: 253.325131ms)","trace[1420728139] 'applied index is now lower than readState.Index'  (duration: 260.826233ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:14.018165Z","caller":"traceutil/trace.go:171","msg":"trace[1032983614] transaction","detail":"{read_only:false; response_revision:25310; number_of_response:1; }","duration":"628.320766ms","start":"2026-06-12T04:03:13.389829Z","end":"2026-06-12T04:03:14.01815Z","steps":["trace[1032983614] 'process raft request'  (duration: 367.34588ms)","trace[1032983614] 'compare'  (duration: 259.59952ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:14.018326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.389807Z","time spent":"628.446348ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25296 > 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-06-12T04:03:14.018879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.100129ms","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-06-12T04:03:14.018943Z","caller":"traceutil/trace.go:171","msg":"trace[1975725925] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25313; }","duration":"776.2097ms","start":"2026-06-12T04:03:13.242719Z","end":"2026-06-12T04:03:14.018928Z","steps":["trace[1975725925] 'agreement among raft nodes before linearized reading'  (duration: 776.099948ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.018981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.2427Z","time spent":"776.269212ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:14.019032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.957068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-06-12T04:03:14.019016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.561456ms","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-06-12T04:03:14.019081Z","caller":"traceutil/trace.go:171","msg":"trace[68435268] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25313; }","duration":"620.035069ms","start":"2026-06-12T04:03:13.399033Z","end":"2026-06-12T04:03:14.019068Z","steps":["trace[68435268] 'agreement among raft nodes before linearized reading'  (duration: 619.883296ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.019116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.399025Z","time spent":"620.08339ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-06-12T04:03:14.018878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.018212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-06-12T04:03:14.019133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.194903ms","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-06-12T04:03:14.019165Z","caller":"traceutil/trace.go:171","msg":"trace[629858996] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:25313; }","duration":"648.349028ms","start":"2026-06-12T04:03:13.370801Z","end":"2026-06-12T04:03:14.01915Z","steps":["trace[629858996] 'agreement among raft nodes before linearized reading'  (duration: 647.985961ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.019193Z","caller":"traceutil/trace.go:171","msg":"trace[436949382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25313; }","duration":"619.262664ms","start":"2026-06-12T04:03:13.399902Z","end":"2026-06-12T04:03:14.019165Z","steps":["trace[436949382] 'agreement among raft nodes before linearized reading'  (duration: 618.941438ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.019229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.370786Z","time spent":"648.416438ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":19,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:14.019249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.399886Z","time spent":"619.350816ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-06-12T04:03:14.019045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.271038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-a7a63068-3419-457e-b773-850130ef4681\" ","response":"range_response_count:1 size:1284"}
{"level":"warn","ts":"2026-06-12T04:03:14.019295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.309285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:14.01932Z","caller":"traceutil/trace.go:171","msg":"trace[719038769] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:25313; }","duration":"402.354076ms","start":"2026-06-12T04:03:13.616957Z","end":"2026-06-12T04:03:14.019311Z","steps":["trace[719038769] 'agreement among raft nodes before linearized reading'  (duration: 402.312546ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.019324Z","caller":"traceutil/trace.go:171","msg":"trace[1176836069] range","detail":"{range_begin:/registry/persistentvolumes/pvc-a7a63068-3419-457e-b773-850130ef4681; range_end:; response_count:1; response_revision:25313; }","duration":"512.575944ms","start":"2026-06-12T04:03:13.506734Z","end":"2026-06-12T04:03:14.01931Z","steps":["trace[1176836069] 'agreement among raft nodes before linearized reading'  (duration: 512.098306ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.01934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.616946Z","time spent":"402.388687ms","remote":"127.0.0.1:47188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:14.019367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.506721Z","time spent":"512.634615ms","remote":"127.0.0.1:54314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1307,"request content":"key:\"/registry/persistentvolumes/pvc-a7a63068-3419-457e-b773-850130ef4681\" "}
{"level":"info","ts":"2026-06-12T04:03:14.019397Z","caller":"traceutil/trace.go:171","msg":"trace[1786254588] transaction","detail":"{read_only:false; response_revision:25311; number_of_response:1; }","duration":"606.591593ms","start":"2026-06-12T04:03:13.412785Z","end":"2026-06-12T04:03:14.019377Z","steps":["trace[1786254588] 'process raft request'  (duration: 604.85734ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.019108Z","caller":"traceutil/trace.go:171","msg":"trace[311632410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25313; }","duration":"593.676137ms","start":"2026-06-12T04:03:13.425408Z","end":"2026-06-12T04:03:14.019085Z","steps":["trace[311632410] 'agreement among raft nodes before linearized reading'  (duration: 593.473044ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.019549Z","caller":"traceutil/trace.go:171","msg":"trace[1459332148] transaction","detail":"{read_only:false; response_revision:25312; number_of_response:1; }","duration":"602.956774ms","start":"2026-06-12T04:03:13.416587Z","end":"2026-06-12T04:03:14.019544Z","steps":["trace[1459332148] 'process raft request'  (duration: 601.18438ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.019591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.534964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-06-12T04:03:14.019627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.416574Z","time spent":"603.002694ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25300 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:14.019623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.968126ms","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-06-12T04:03:14.019648Z","caller":"traceutil/trace.go:171","msg":"trace[925430058] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25313; }","duration":"439.612295ms","start":"2026-06-12T04:03:13.580021Z","end":"2026-06-12T04:03:14.019634Z","steps":["trace[925430058] 'agreement among raft nodes before linearized reading'  (duration: 439.464933ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.019668Z","caller":"traceutil/trace.go:171","msg":"trace[1565344341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25313; }","duration":"591.028897ms","start":"2026-06-12T04:03:13.428628Z","end":"2026-06-12T04:03:14.019657Z","steps":["trace[1565344341] 'agreement among raft nodes before linearized reading'  (duration: 590.198832ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.0197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.580009Z","time spent":"439.678397ms","remote":"127.0.0.1:54352","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-06-12T04:03:14.019705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.428618Z","time spent":"591.077238ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-06-12T04:03:14.019527Z","caller":"traceutil/trace.go:171","msg":"trace[256187074] transaction","detail":"{read_only:false; response_revision:25313; number_of_response:1; }","duration":"601.1842ms","start":"2026-06-12T04:03:13.418333Z","end":"2026-06-12T04:03:14.019517Z","steps":["trace[256187074] 'process raft request'  (duration: 599.494568ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.01991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.418316Z","time spent":"601.552788ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25301 > 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-06-12T04:03:14.01984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.847729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-06-12T04:03:14.020069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.425398Z","time spent":"594.217127ms","remote":"127.0.0.1:54452","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-06-12T04:03:14.020061Z","caller":"traceutil/trace.go:171","msg":"trace[380816529] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:25313; }","duration":"866.00309ms","start":"2026-06-12T04:03:13.154039Z","end":"2026-06-12T04:03:14.020042Z","steps":["trace[380816529] 'agreement among raft nodes before linearized reading'  (duration: 864.838638ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.020433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.154013Z","time spent":"866.354527ms","remote":"127.0.0.1:55622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":23,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true "}
{"level":"warn","ts":"2026-06-12T04:03:14.019526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.412772Z","time spent":"606.674385ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25299 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-12T04:03:14.018912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.359337ms","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-06-12T04:03:14.021131Z","caller":"traceutil/trace.go:171","msg":"trace[1313792563] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25313; }","duration":"703.57806ms","start":"2026-06-12T04:03:13.317537Z","end":"2026-06-12T04:03:14.021115Z","steps":["trace[1313792563] 'agreement among raft nodes before linearized reading'  (duration: 701.270675ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.021456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:13.317479Z","time spent":"703.960957ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-06-12T04:03:14.319127Z","caller":"traceutil/trace.go:171","msg":"trace[754709777] transaction","detail":"{read_only:false; response_revision:25315; number_of_response:1; }","duration":"294.8198ms","start":"2026-06-12T04:03:14.024277Z","end":"2026-06-12T04:03:14.319097Z","steps":["trace[754709777] 'process raft request'  (duration: 293.637507ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.319804Z","caller":"traceutil/trace.go:171","msg":"trace[728312479] transaction","detail":"{read_only:false; response_revision:25316; number_of_response:1; }","duration":"294.936923ms","start":"2026-06-12T04:03:14.024833Z","end":"2026-06-12T04:03:14.31977Z","steps":["trace[728312479] 'process raft request'  (duration: 294.571236ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.319976Z","caller":"traceutil/trace.go:171","msg":"trace[1635145253] transaction","detail":"{read_only:false; response_revision:25317; number_of_response:1; }","duration":"294.668448ms","start":"2026-06-12T04:03:14.025296Z","end":"2026-06-12T04:03:14.319965Z","steps":["trace[1635145253] 'process raft request'  (duration: 294.429994ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.320225Z","caller":"traceutil/trace.go:171","msg":"trace[1590756446] linearizableReadLoop","detail":"{readStateIndex:26140; appliedIndex:26136; }","duration":"234.308259ms","start":"2026-06-12T04:03:14.085901Z","end":"2026-06-12T04:03:14.320209Z","steps":["trace[1590756446] 'read index received'  (duration: 231.926293ms)","trace[1590756446] 'applied index is now lower than readState.Index'  (duration: 2.380696ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:14.320329Z","caller":"traceutil/trace.go:171","msg":"trace[1093728715] transaction","detail":"{read_only:false; response_revision:25318; number_of_response:1; }","duration":"291.595279ms","start":"2026-06-12T04:03:14.028721Z","end":"2026-06-12T04:03:14.320316Z","steps":["trace[1093728715] 'process raft request'  (duration: 291.182811ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:14.320566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.871203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1e4c6219-301d-43ee-8d48-a717ce5e912a\" ","response":"range_response_count:1 size:1323"}
{"level":"warn","ts":"2026-06-12T04:03:14.320587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.377532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18557"}
{"level":"info","ts":"2026-06-12T04:03:14.320609Z","caller":"traceutil/trace.go:171","msg":"trace[685726801] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1e4c6219-301d-43ee-8d48-a717ce5e912a; range_end:; response_count:1; response_revision:25318; }","duration":"293.941984ms","start":"2026-06-12T04:03:14.026656Z","end":"2026-06-12T04:03:14.320598Z","steps":["trace[685726801] 'agreement among raft nodes before linearized reading'  (duration: 293.753801ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:14.320618Z","caller":"traceutil/trace.go:171","msg":"trace[1288023764] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25318; }","duration":"232.444543ms","start":"2026-06-12T04:03:14.088165Z","end":"2026-06-12T04:03:14.320609Z","steps":["trace[1288023764] 'agreement among raft nodes before linearized reading'  (duration: 232.311731ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:20.961853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.310781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-32c6853c-712a-4bea-a9ce-e65292b8c60b\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-06-12T04:03:20.961958Z","caller":"traceutil/trace.go:171","msg":"trace[185581159] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-32c6853c-712a-4bea-a9ce-e65292b8c60b; range_end:; response_count:1; response_revision:25425; }","duration":"119.474985ms","start":"2026-06-12T04:03:20.84246Z","end":"2026-06-12T04:03:20.961935Z","steps":["trace[185581159] 'range keys from in-memory index tree'  (duration: 119.126738ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:20.961867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.178715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:03:20.962166Z","caller":"traceutil/trace.go:171","msg":"trace[1338349437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25425; }","duration":"205.521772ms","start":"2026-06-12T04:03:20.756586Z","end":"2026-06-12T04:03:20.962108Z","steps":["trace[1338349437] 'range keys from in-memory index tree'  (duration: 205.089883ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:21.184809Z","caller":"traceutil/trace.go:171","msg":"trace[66892590] transaction","detail":"{read_only:false; response_revision:25427; number_of_response:1; }","duration":"237.395258ms","start":"2026-06-12T04:03:20.947382Z","end":"2026-06-12T04:03:21.184778Z","steps":["trace[66892590] 'process raft request'  (duration: 237.222135ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:21.452473Z","caller":"traceutil/trace.go:171","msg":"trace[1878374270] transaction","detail":"{read_only:false; response_revision:25428; number_of_response:1; }","duration":"233.85726ms","start":"2026-06-12T04:03:21.218581Z","end":"2026-06-12T04:03:21.452438Z","steps":["trace[1878374270] 'process raft request'  (duration: 233.620876ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:21.770892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.8023ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187782211 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:54ce9eb9d2e9a042>","response":"size:41"}
{"level":"warn","ts":"2026-06-12T04:03:21.771023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:21.453651Z","time spent":"317.36573ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-06-12T04:03:21.820655Z","caller":"traceutil/trace.go:171","msg":"trace[1396495346] transaction","detail":"{read_only:false; response_revision:25429; number_of_response:1; }","duration":"291.766932ms","start":"2026-06-12T04:03:21.528863Z","end":"2026-06-12T04:03:21.82063Z","steps":["trace[1396495346] 'process raft request'  (duration: 291.507437ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:22.029108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.444155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-manila-server-0.18b8399d2a5f40a7\" ","response":"range_response_count:1 size:1010"}
{"level":"info","ts":"2026-06-12T04:03:22.029202Z","caller":"traceutil/trace.go:171","msg":"trace[607554144] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-manila-server-0.18b8399d2a5f40a7; range_end:; response_count:1; response_revision:25430; }","duration":"127.580498ms","start":"2026-06-12T04:03:21.901598Z","end":"2026-06-12T04:03:22.029178Z","steps":["trace[607554144] 'range keys from in-memory index tree'  (duration: 127.241072ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:22.210927Z","caller":"traceutil/trace.go:171","msg":"trace[1095798748] linearizableReadLoop","detail":"{readStateIndex:26260; appliedIndex:26255; }","duration":"152.578224ms","start":"2026-06-12T04:03:22.05833Z","end":"2026-06-12T04:03:22.210908Z","steps":["trace[1095798748] 'read index received'  (duration: 1.985777ms)","trace[1095798748] 'applied index is now lower than readState.Index'  (duration: 150.591427ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:22.211198Z","caller":"traceutil/trace.go:171","msg":"trace[1545398842] transaction","detail":"{read_only:false; response_revision:25435; number_of_response:1; }","duration":"159.936824ms","start":"2026-06-12T04:03:22.051203Z","end":"2026-06-12T04:03:22.21114Z","steps":["trace[1545398842] 'process raft request'  (duration: 159.670209ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:22.211249Z","caller":"traceutil/trace.go:171","msg":"trace[1538652163] transaction","detail":"{read_only:false; response_revision:25434; number_of_response:1; }","duration":"162.073675ms","start":"2026-06-12T04:03:22.049165Z","end":"2026-06-12T04:03:22.211239Z","steps":["trace[1538652163] 'process raft request'  (duration: 161.677377ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:22.211271Z","caller":"traceutil/trace.go:171","msg":"trace[1646879400] transaction","detail":"{read_only:false; response_revision:25433; number_of_response:1; }","duration":"162.239428ms","start":"2026-06-12T04:03:22.049001Z","end":"2026-06-12T04:03:22.211241Z","steps":["trace[1646879400] 'process raft request'  (duration: 161.80925ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:22.211357Z","caller":"traceutil/trace.go:171","msg":"trace[909020270] transaction","detail":"{read_only:false; response_revision:25432; number_of_response:1; }","duration":"165.318976ms","start":"2026-06-12T04:03:22.046029Z","end":"2026-06-12T04:03:22.211348Z","steps":["trace[909020270] 'process raft request'  (duration: 153.054952ms)","trace[909020270] 'compare'  (duration: 11.620292ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:22.211477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.110363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:276063"}
{"level":"info","ts":"2026-06-12T04:03:22.211557Z","caller":"traceutil/trace.go:171","msg":"trace[1567732010] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:25435; }","duration":"153.233276ms","start":"2026-06-12T04:03:22.058304Z","end":"2026-06-12T04:03:22.211538Z","steps":["trace[1567732010] 'agreement among raft nodes before linearized reading'  (duration: 152.831379ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:24.472149Z","caller":"traceutil/trace.go:171","msg":"trace[1111735784] transaction","detail":"{read_only:false; response_revision:25455; number_of_response:1; }","duration":"109.147307ms","start":"2026-06-12T04:03:24.362967Z","end":"2026-06-12T04:03:24.472114Z","steps":["trace[1111735784] 'process raft request'  (duration: 108.617277ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:24.741023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.257752ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187782274 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25438 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:24.741241Z","caller":"traceutil/trace.go:171","msg":"trace[1656631205] transaction","detail":"{read_only:false; response_revision:25458; number_of_response:1; }","duration":"222.382872ms","start":"2026-06-12T04:03:24.51884Z","end":"2026-06-12T04:03:24.741223Z","steps":["trace[1656631205] 'process raft request'  (duration: 222.340391ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:24.741369Z","caller":"traceutil/trace.go:171","msg":"trace[1879483606] transaction","detail":"{read_only:false; response_revision:25457; number_of_response:1; }","duration":"375.76799ms","start":"2026-06-12T04:03:24.365592Z","end":"2026-06-12T04:03:24.74136Z","steps":["trace[1879483606] 'process raft request'  (duration: 375.521395ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:24.741429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:24.365584Z","time spent":"375.812211ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25439 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-06-12T04:03:24.741573Z","caller":"traceutil/trace.go:171","msg":"trace[2141217542] transaction","detail":"{read_only:false; response_revision:25456; number_of_response:1; }","duration":"378.082585ms","start":"2026-06-12T04:03:24.363458Z","end":"2026-06-12T04:03:24.741541Z","steps":["trace[2141217542] 'process raft request'  (duration: 230.221312ms)","trace[2141217542] 'compare'  (duration: 146.925956ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:24.741656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:24.363438Z","time spent":"378.171466ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25438 > 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-06-12T04:03:24.741758Z","caller":"traceutil/trace.go:171","msg":"trace[1959364811] linearizableReadLoop","detail":"{readStateIndex:26281; appliedIndex:26279; }","duration":"376.838821ms","start":"2026-06-12T04:03:24.364566Z","end":"2026-06-12T04:03:24.741405Z","steps":["trace[1959364811] 'read index received'  (duration: 107.054076ms)","trace[1959364811] 'applied index is now lower than readState.Index'  (duration: 269.781525ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:24.74182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.249418ms","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-06-12T04:03:24.741865Z","caller":"traceutil/trace.go:171","msg":"trace[444353862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25458; }","duration":"377.308ms","start":"2026-06-12T04:03:24.364546Z","end":"2026-06-12T04:03:24.741854Z","steps":["trace[444353862] 'agreement among raft nodes before linearized reading'  (duration: 377.181347ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:24.741894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T04:03:24.364539Z","time spent":"377.34887ms","remote":"127.0.0.1:54452","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":"warn","ts":"2026-06-12T04:03:24.751412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.758212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"}
{"level":"info","ts":"2026-06-12T04:03:24.751443Z","caller":"traceutil/trace.go:171","msg":"trace[196200471] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25459; }","duration":"105.824043ms","start":"2026-06-12T04:03:24.645611Z","end":"2026-06-12T04:03:24.751435Z","steps":["trace[196200471] 'agreement among raft nodes before linearized reading'  (duration: 105.724622ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:24.751446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.663377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"warn","ts":"2026-06-12T04:03:24.751412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.299838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-06-12T04:03:24.751477Z","caller":"traceutil/trace.go:171","msg":"trace[565377008] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25459; }","duration":"180.732229ms","start":"2026-06-12T04:03:24.570736Z","end":"2026-06-12T04:03:24.751468Z","steps":["trace[565377008] 'agreement among raft nodes before linearized reading'  (duration: 180.641477ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:24.751497Z","caller":"traceutil/trace.go:171","msg":"trace[1551682533] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25459; }","duration":"255.43324ms","start":"2026-06-12T04:03:24.496046Z","end":"2026-06-12T04:03:24.751479Z","steps":["trace[1551682533] 'agreement among raft nodes before linearized reading'  (duration: 255.187676ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:29.340888Z","caller":"traceutil/trace.go:171","msg":"trace[264574726] transaction","detail":"{read_only:false; response_revision:25512; number_of_response:1; }","duration":"132.285377ms","start":"2026-06-12T04:03:29.20858Z","end":"2026-06-12T04:03:29.340865Z","steps":["trace[264574726] 'process raft request'  (duration: 132.072763ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:32.426769Z","caller":"traceutil/trace.go:171","msg":"trace[1845898511] linearizableReadLoop","detail":"{readStateIndex:26365; appliedIndex:26361; }","duration":"169.369783ms","start":"2026-06-12T04:03:32.257374Z","end":"2026-06-12T04:03:32.426743Z","steps":["trace[1845898511] 'read index received'  (duration: 26.382462ms)","trace[1845898511] 'applied index is now lower than readState.Index'  (duration: 142.986381ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:32.426989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.591237ms","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-06-12T04:03:32.426997Z","caller":"traceutil/trace.go:171","msg":"trace[857000342] transaction","detail":"{read_only:false; response_revision:25537; number_of_response:1; }","duration":"178.277982ms","start":"2026-06-12T04:03:32.248677Z","end":"2026-06-12T04:03:32.426955Z","steps":["trace[857000342] 'process raft request'  (duration: 177.965396ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:32.427033Z","caller":"traceutil/trace.go:171","msg":"trace[1319454462] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25538; }","duration":"169.683179ms","start":"2026-06-12T04:03:32.257336Z","end":"2026-06-12T04:03:32.427019Z","steps":["trace[1319454462] 'agreement among raft nodes before linearized reading'  (duration: 169.524146ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:32.42707Z","caller":"traceutil/trace.go:171","msg":"trace[278403586] transaction","detail":"{read_only:false; response_revision:25538; number_of_response:1; }","duration":"177.745702ms","start":"2026-06-12T04:03:32.249275Z","end":"2026-06-12T04:03:32.427021Z","steps":["trace[278403586] 'process raft request'  (duration: 177.421016ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:32.427169Z","caller":"traceutil/trace.go:171","msg":"trace[226376948] transaction","detail":"{read_only:false; response_revision:25536; number_of_response:1; }","duration":"179.73476ms","start":"2026-06-12T04:03:32.247395Z","end":"2026-06-12T04:03:32.427129Z","steps":["trace[226376948] 'process raft request'  (duration: 126.722212ms)","trace[226376948] 'compare'  (duration: 52.391647ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:37.298886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.013014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-06-12T04:03:37.298967Z","caller":"traceutil/trace.go:171","msg":"trace[1317651084] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25579; }","duration":"121.110926ms","start":"2026-06-12T04:03:37.177836Z","end":"2026-06-12T04:03:37.298947Z","steps":["trace[1317651084] 'range keys from in-memory index tree'  (duration: 120.827509ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:38.560125Z","caller":"traceutil/trace.go:171","msg":"trace[1121969194] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"113.035992ms","start":"2026-06-12T04:03:38.447033Z","end":"2026-06-12T04:03:38.560069Z","steps":["trace[1121969194] 'process raft request'  (duration: 81.395269ms)","trace[1121969194] 'compare'  (duration: 31.430209ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:38.560248Z","caller":"traceutil/trace.go:171","msg":"trace[957070504] linearizableReadLoop","detail":"{readStateIndex:26413; appliedIndex:26411; }","duration":"109.27425ms","start":"2026-06-12T04:03:38.450943Z","end":"2026-06-12T04:03:38.560218Z","steps":["trace[957070504] 'read index received'  (duration: 77.410813ms)","trace[957070504] 'applied index is now lower than readState.Index'  (duration: 31.862557ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:38.560438Z","caller":"traceutil/trace.go:171","msg":"trace[874628635] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"113.247835ms","start":"2026-06-12T04:03:38.447156Z","end":"2026-06-12T04:03:38.560404Z","steps":["trace[874628635] 'process raft request'  (duration: 112.855348ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:38.560515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.552505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-06-12T04:03:38.560547Z","caller":"traceutil/trace.go:171","msg":"trace[58018782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25585; }","duration":"109.623845ms","start":"2026-06-12T04:03:38.450915Z","end":"2026-06-12T04:03:38.560539Z","steps":["trace[58018782] 'agreement among raft nodes before linearized reading'  (duration: 109.440692ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:40.449453Z","caller":"traceutil/trace.go:171","msg":"trace[2040629440] transaction","detail":"{read_only:false; response_revision:25596; number_of_response:1; }","duration":"140.028165ms","start":"2026-06-12T04:03:40.309402Z","end":"2026-06-12T04:03:40.44943Z","steps":["trace[2040629440] 'process raft request'  (duration: 139.857472ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:52.68561Z","caller":"traceutil/trace.go:171","msg":"trace[1788126459] transaction","detail":"{read_only:false; response_revision:25697; number_of_response:1; }","duration":"149.377822ms","start":"2026-06-12T04:03:52.536205Z","end":"2026-06-12T04:03:52.685583Z","steps":["trace[1788126459] 'process raft request'  (duration: 74.267804ms)","trace[1788126459] 'compare'  (duration: 74.6575ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:52.731545Z","caller":"traceutil/trace.go:171","msg":"trace[1010743455] transaction","detail":"{read_only:false; response_revision:25698; number_of_response:1; }","duration":"122.291347ms","start":"2026-06-12T04:03:52.609224Z","end":"2026-06-12T04:03:52.731515Z","steps":["trace[1010743455] 'process raft request'  (duration: 122.141184ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:52.751184Z","caller":"traceutil/trace.go:171","msg":"trace[1842150382] linearizableReadLoop","detail":"{readStateIndex:26530; appliedIndex:26528; }","duration":"134.00561ms","start":"2026-06-12T04:03:52.617148Z","end":"2026-06-12T04:03:52.751154Z","steps":["trace[1842150382] 'read index received'  (duration: 114.335036ms)","trace[1842150382] 'applied index is now lower than readState.Index'  (duration: 19.669204ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:52.751302Z","caller":"traceutil/trace.go:171","msg":"trace[726205013] transaction","detail":"{read_only:false; response_revision:25699; number_of_response:1; }","duration":"139.641236ms","start":"2026-06-12T04:03:52.611632Z","end":"2026-06-12T04:03:52.751273Z","steps":["trace[726205013] 'process raft request'  (duration: 139.338891ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:52.751437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.261995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-06-12T04:03:52.751503Z","caller":"traceutil/trace.go:171","msg":"trace[207438069] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25699; }","duration":"134.387987ms","start":"2026-06-12T04:03:52.617104Z","end":"2026-06-12T04:03:52.751492Z","steps":["trace[207438069] 'agreement among raft nodes before linearized reading'  (duration: 134.187264ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:52.751589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.531375ms","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-06-12T04:03:52.751667Z","caller":"traceutil/trace.go:171","msg":"trace[278738580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25699; }","duration":"128.653558ms","start":"2026-06-12T04:03:52.622992Z","end":"2026-06-12T04:03:52.751645Z","steps":["trace[278738580] 'agreement among raft nodes before linearized reading'  (duration: 128.448834ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:52.893046Z","caller":"traceutil/trace.go:171","msg":"trace[616604111] transaction","detail":"{read_only:false; response_revision:25701; number_of_response:1; }","duration":"135.907237ms","start":"2026-06-12T04:03:52.757113Z","end":"2026-06-12T04:03:52.89302Z","steps":["trace[616604111] 'process raft request'  (duration: 85.930245ms)","trace[616604111] 'compare'  (duration: 49.775527ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:53.125852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.913439ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187782870 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25690 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:53.126111Z","caller":"traceutil/trace.go:171","msg":"trace[1015170089] linearizableReadLoop","detail":"{readStateIndex:26535; appliedIndex:26533; }","duration":"172.926812ms","start":"2026-06-12T04:03:52.953159Z","end":"2026-06-12T04:03:53.126086Z","steps":["trace[1015170089] 'read index received'  (duration: 48.611796ms)","trace[1015170089] 'applied index is now lower than readState.Index'  (duration: 124.313795ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:53.126189Z","caller":"traceutil/trace.go:171","msg":"trace[1492163550] transaction","detail":"{read_only:false; response_revision:25703; number_of_response:1; }","duration":"216.898868ms","start":"2026-06-12T04:03:52.909266Z","end":"2026-06-12T04:03:53.126164Z","steps":["trace[1492163550] 'process raft request'  (duration: 92.548141ms)","trace[1492163550] 'compare'  (duration: 123.687135ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:53.126251Z","caller":"traceutil/trace.go:171","msg":"trace[429365575] transaction","detail":"{read_only:false; response_revision:25704; number_of_response:1; }","duration":"216.50849ms","start":"2026-06-12T04:03:52.909727Z","end":"2026-06-12T04:03:53.126236Z","steps":["trace[429365575] 'process raft request'  (duration: 216.258356ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:53.126431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.715474ms","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-06-12T04:03:53.126497Z","caller":"traceutil/trace.go:171","msg":"trace[1096717145] 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:25704; }","duration":"113.821136ms","start":"2026-06-12T04:03:53.012658Z","end":"2026-06-12T04:03:53.12648Z","steps":["trace[1096717145] 'agreement among raft nodes before linearized reading'  (duration: 113.691873ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:53.126506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.951191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-06-12T04:03:53.126576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.394056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418379"}
{"level":"info","ts":"2026-06-12T04:03:53.126597Z","caller":"traceutil/trace.go:171","msg":"trace[825373227] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:25704; }","duration":"114.459068ms","start":"2026-06-12T04:03:53.012132Z","end":"2026-06-12T04:03:53.126591Z","steps":["trace[825373227] 'agreement among raft nodes before linearized reading'  (duration: 114.283455ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:53.126585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.3896ms","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-06-12T04:03:53.126611Z","caller":"traceutil/trace.go:171","msg":"trace[1395091251] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25704; }","duration":"141.120665ms","start":"2026-06-12T04:03:52.985467Z","end":"2026-06-12T04:03:53.126588Z","steps":["trace[1395091251] 'agreement among raft nodes before linearized reading'  (duration: 140.896431ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:53.12667Z","caller":"traceutil/trace.go:171","msg":"trace[686410270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25704; }","duration":"173.527743ms","start":"2026-06-12T04:03:52.953118Z","end":"2026-06-12T04:03:53.126645Z","steps":["trace[686410270] 'agreement among raft nodes before linearized reading'  (duration: 173.253418ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:53.325752Z","caller":"traceutil/trace.go:171","msg":"trace[905642221] transaction","detail":"{read_only:false; response_revision:25706; number_of_response:1; }","duration":"111.36173ms","start":"2026-06-12T04:03:53.214368Z","end":"2026-06-12T04:03:53.32573Z","steps":["trace[905642221] 'process raft request'  (duration: 104.375337ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:53.555021Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067ac.wal"}
{"level":"info","ts":"2026-06-12T04:03:54.949018Z","caller":"traceutil/trace.go:171","msg":"trace[1250546360] transaction","detail":"{read_only:false; response_revision:25714; number_of_response:1; }","duration":"140.173637ms","start":"2026-06-12T04:03:54.808795Z","end":"2026-06-12T04:03:54.948968Z","steps":["trace[1250546360] 'process raft request'  (duration: 109.8765ms)","trace[1250546360] 'compare'  (duration: 29.842829ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:55.028355Z","caller":"traceutil/trace.go:171","msg":"trace[481252689] transaction","detail":"{read_only:false; response_revision:25715; number_of_response:1; }","duration":"123.41576ms","start":"2026-06-12T04:03:54.904913Z","end":"2026-06-12T04:03:55.028329Z","steps":["trace[481252689] 'process raft request'  (duration: 123.273766ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:55.459098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.946668ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187782908 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25704 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:03:55.459203Z","caller":"traceutil/trace.go:171","msg":"trace[289620764] linearizableReadLoop","detail":"{readStateIndex:26549; appliedIndex:26548; }","duration":"266.188565ms","start":"2026-06-12T04:03:55.192996Z","end":"2026-06-12T04:03:55.459185Z","steps":["trace[289620764] 'read index received'  (duration: 70.137684ms)","trace[289620764] 'applied index is now lower than readState.Index'  (duration: 196.049851ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:03:55.459234Z","caller":"traceutil/trace.go:171","msg":"trace[1157288218] transaction","detail":"{read_only:false; response_revision:25718; number_of_response:1; }","duration":"267.955848ms","start":"2026-06-12T04:03:55.19125Z","end":"2026-06-12T04:03:55.459206Z","steps":["trace[1157288218] 'process raft request'  (duration: 143.813857ms)","trace[1157288218] 'compare'  (duration: 123.828666ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:03:55.459372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.372808ms","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-06-12T04:03:55.459408Z","caller":"traceutil/trace.go:171","msg":"trace[2030883859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25718; }","duration":"266.43555ms","start":"2026-06-12T04:03:55.192963Z","end":"2026-06-12T04:03:55.459398Z","steps":["trace[2030883859] 'agreement among raft nodes before linearized reading'  (duration: 266.296897ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:03:55.461635Z","caller":"traceutil/trace.go:171","msg":"trace[2017834883] transaction","detail":"{read_only:false; response_revision:25719; number_of_response:1; }","duration":"130.512863ms","start":"2026-06-12T04:03:55.331088Z","end":"2026-06-12T04:03:55.461601Z","steps":["trace[2017834883] 'process raft request'  (duration: 130.364061ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:03:55.461696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.22731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-06-12T04:03:55.461739Z","caller":"traceutil/trace.go:171","msg":"trace[2113503125] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25719; }","duration":"221.328452ms","start":"2026-06-12T04:03:55.2404Z","end":"2026-06-12T04:03:55.461728Z","steps":["trace[2113503125] 'agreement among raft nodes before linearized reading'  (duration: 221.157479ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:04:06.040418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.830986ms","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-06-12T04:04:06.04051Z","caller":"traceutil/trace.go:171","msg":"trace[616406292] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25800; }","duration":"114.945978ms","start":"2026-06-12T04:04:05.925538Z","end":"2026-06-12T04:04:06.040484Z","steps":["trace[616406292] 'range keys from in-memory index tree'  (duration: 114.683842ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:04:06.190904Z","caller":"traceutil/trace.go:171","msg":"trace[132031723] transaction","detail":"{read_only:false; response_revision:25803; number_of_response:1; }","duration":"114.270325ms","start":"2026-06-12T04:04:06.076598Z","end":"2026-06-12T04:04:06.190868Z","steps":["trace[132031723] 'process raft request'  (duration: 101.086255ms)","trace[132031723] 'compare'  (duration: 12.916335ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:04:06.410023Z","caller":"traceutil/trace.go:171","msg":"trace[1150403330] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"210.819762ms","start":"2026-06-12T04:04:06.199172Z","end":"2026-06-12T04:04:06.409991Z","steps":["trace[1150403330] 'process raft request'  (duration: 133.345417ms)","trace[1150403330] 'compare'  (duration: 76.850573ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:04:06.692369Z","caller":"traceutil/trace.go:171","msg":"trace[1354845881] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"110.641176ms","start":"2026-06-12T04:04:06.581695Z","end":"2026-06-12T04:04:06.692336Z","steps":["trace[1354845881] 'process raft request'  (duration: 54.65991ms)","trace[1354845881] 'compare'  (duration: 55.822083ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:04:17.058458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.524722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187783288 > lease_revoke:<id:54ce9eb9d2e9a368>","response":"size:29"}
{"level":"info","ts":"2026-06-12T04:04:17.059033Z","caller":"traceutil/trace.go:171","msg":"trace[559416989] transaction","detail":"{read_only:false; response_revision:25884; number_of_response:1; }","duration":"185.874007ms","start":"2026-06-12T04:04:16.873134Z","end":"2026-06-12T04:04:17.059008Z","steps":["trace[559416989] 'process raft request'  (duration: 185.764445ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:04:17.059044Z","caller":"traceutil/trace.go:171","msg":"trace[1256182599] transaction","detail":"{read_only:false; response_revision:25883; number_of_response:1; }","duration":"199.971166ms","start":"2026-06-12T04:04:16.85904Z","end":"2026-06-12T04:04:17.059011Z","steps":["trace[1256182599] 'process raft request'  (duration: 199.65655ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:04:17.059172Z","caller":"traceutil/trace.go:171","msg":"trace[1151038621] transaction","detail":"{read_only:false; response_revision:25885; number_of_response:1; }","duration":"185.099262ms","start":"2026-06-12T04:04:16.874041Z","end":"2026-06-12T04:04:17.05914Z","steps":["trace[1151038621] 'process raft request'  (duration: 184.911389ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:04:17.425756Z","caller":"traceutil/trace.go:171","msg":"trace[2109058671] transaction","detail":"{read_only:false; response_revision:25888; number_of_response:1; }","duration":"217.00198ms","start":"2026-06-12T04:04:17.208691Z","end":"2026-06-12T04:04:17.425693Z","steps":["trace[2109058671] 'process raft request'  (duration: 142.985641ms)","trace[2109058671] 'compare'  (duration: 73.811765ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-12T04:04:17.792001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.481475ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334368302187783303 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25876 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-12T04:04:17.792196Z","caller":"traceutil/trace.go:171","msg":"trace[1296577744] transaction","detail":"{read_only:false; response_revision:25891; number_of_response:1; }","duration":"177.341835ms","start":"2026-06-12T04:04:17.614809Z","end":"2026-06-12T04:04:17.79215Z","steps":["trace[1296577744] 'process raft request'  (duration: 37.584345ms)","trace[1296577744] 'compare'  (duration: 139.127117ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:04:17.792267Z","caller":"traceutil/trace.go:171","msg":"trace[1341385358] linearizableReadLoop","detail":"{readStateIndex:26727; appliedIndex:26726; }","duration":"162.799858ms","start":"2026-06-12T04:04:17.629439Z","end":"2026-06-12T04:04:17.792238Z","steps":["trace[1341385358] 'read index received'  (duration: 22.962936ms)","trace[1341385358] 'applied index is now lower than readState.Index'  (duration: 139.832821ms)"],"step_count":2}
{"level":"info","ts":"2026-06-12T04:04:17.795934Z","caller":"traceutil/trace.go:171","msg":"trace[656217963] transaction","detail":"{read_only:false; response_revision:25892; number_of_response:1; }","duration":"166.259235ms","start":"2026-06-12T04:04:17.629633Z","end":"2026-06-12T04:04:17.795892Z","steps":["trace[656217963] 'process raft request'  (duration: 162.515413ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:04:17.796037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.376249ms","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-06-12T04:04:17.796106Z","caller":"traceutil/trace.go:171","msg":"trace[388325834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25892; }","duration":"164.486601ms","start":"2026-06-12T04:04:17.631602Z","end":"2026-06-12T04:04:17.796088Z","steps":["trace[388325834] 'agreement among raft nodes before linearized reading'  (duration: 164.266047ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-12T04:04:17.796166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.706863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-12T04:04:17.796205Z","caller":"traceutil/trace.go:171","msg":"trace[45995304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25892; }","duration":"166.814254ms","start":"2026-06-12T04:04:17.62938Z","end":"2026-06-12T04:04:17.796194Z","steps":["trace[45995304] 'agreement among raft nodes before linearized reading'  (duration: 162.993201ms)"],"step_count":1}
{"level":"info","ts":"2026-06-12T04:04:28.393194Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23046}
{"level":"info","ts":"2026-06-12T04:04:28.525024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23046,"took":"127.509658ms","hash":2656861178,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":36364288,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-06-12T04:04:28.525104Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2656861178,"revision":23046,"compact-revision":20186}
{"level":"info","ts":"2026-06-12T04:09:28.399541Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25969}
{"level":"info","ts":"2026-06-12T04:09:28.53961Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25969,"took":"136.335715ms","hash":2791924563,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":36032512,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-06-12T04:09:28.539691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2791924563,"revision":25969,"compact-revision":23046}
{"level":"info","ts":"2026-06-12T04:09:56.900328Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-12T04:09:56.905982Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-06-12T04:09:56.906054Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-06-12T04:14:28.405826Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28875}
{"level":"info","ts":"2026-06-12T04:14:28.558579Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28875,"took":"148.594668ms","hash":1704975099,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":31162368,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-12T04:14:28.558659Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1704975099,"revision":28875,"compact-revision":25969}
{"level":"info","ts":"2026-06-12T04:19:28.411537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31095}
{"level":"info","ts":"2026-06-12T04:19:28.548655Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31095,"took":"131.733546ms","hash":1796318135,"current-db-size-bytes":58703872,"current-db-size":"59 MB","current-db-size-in-use-bytes":30691328,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-12T04:19:28.548735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1796318135,"revision":31095,"compact-revision":28875}
{"level":"info","ts":"2026-06-12T04:24:28.417033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33358}
{"level":"info","ts":"2026-06-12T04:24:28.573217Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33358,"took":"151.015923ms","hash":1390758587,"current-db-size-bytes":59748352,"current-db-size":"60 MB","current-db-size-in-use-bytes":31739904,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-12T04:24:28.573297Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1390758587,"revision":33358,"compact-revision":31095}
{"level":"info","ts":"2026-06-12T04:29:28.425987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35655}
{"level":"info","ts":"2026-06-12T04:29:28.584615Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35655,"took":"153.7577ms","hash":891928795,"current-db-size-bytes":59748352,"current-db-size":"60 MB","current-db-size-in-use-bytes":31440896,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-12T04:29:28.584684Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":891928795,"revision":35655,"compact-revision":33358}
{"level":"info","ts":"2026-06-12T04:31:22.998925Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-12T04:31:23.005942Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-06-12T04:31:23.006119Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-06-12T04:34:28.433435Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37882}
{"level":"info","ts":"2026-06-12T04:34:28.560036Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37882,"took":"119.120222ms","hash":3575554497,"current-db-size-bytes":59748352,"current-db-size":"60 MB","current-db-size-in-use-bytes":32641024,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-06-12T04:34:28.560116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3575554497,"revision":37882,"compact-revision":35655}