{"level":"warn","ts":"2026-10-01T19:14:50.63414Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-01T19:14:50.634268Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.211:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.211:2380","--initial-cluster=instance=https://162.253.55.211:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.211:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.211:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-01T19:14:50.634369Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-01T19:14:50.634408Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.211:2380"]}
{"level":"info","ts":"2026-10-01T19:14:50.634451Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-01T19:14:50.635211Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.211:2379"]}
{"level":"info","ts":"2026-10-01T19:14:50.635348Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.211:2380"],"listen-peer-urls":["https://162.253.55.211:2380"],"advertise-client-urls":["https://162.253.55.211:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.211:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.211:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-01T19:14:50.63828Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.68458ms"}
{"level":"info","ts":"2026-10-01T19:14:50.644472Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"931f6a422b4c426f","cluster-id":"8a95cf5058d193ed"}
{"level":"info","ts":"2026-10-01T19:14:50.644572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f switched to configuration voters=()"}
{"level":"info","ts":"2026-10-01T19:14:50.644609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f became follower at term 0"}
{"level":"info","ts":"2026-10-01T19:14:50.644632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 931f6a422b4c426f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-01T19:14:50.644658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f became follower at term 1"}
{"level":"info","ts":"2026-10-01T19:14:50.644711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f switched to configuration voters=(10601308880280240751)"}
{"level":"warn","ts":"2026-10-01T19:14:50.652053Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-01T19:14:50.653663Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-01T19:14:50.655469Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-10-01T19:14:50.657838Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"931f6a422b4c426f","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-01T19:14:50.658013Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"931f6a422b4c426f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-01T19:14:50.658111Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-01T19:14:50.658228Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-01T19:14:50.658239Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-01T19:14:50.660313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f switched to configuration voters=(10601308880280240751)"}
{"level":"info","ts":"2026-10-01T19:14:50.660555Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8a95cf5058d193ed","local-member-id":"931f6a422b4c426f","added-peer-id":"931f6a422b4c426f","added-peer-peer-urls":["https://162.253.55.211:2380"]}
{"level":"info","ts":"2026-10-01T19:14:50.662653Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-01T19:14:50.662746Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.211:2380"}
{"level":"info","ts":"2026-10-01T19:14:50.662765Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.211:2380"}
{"level":"info","ts":"2026-10-01T19:14:50.662967Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"931f6a422b4c426f","initial-advertise-peer-urls":["https://162.253.55.211:2380"],"listen-peer-urls":["https://162.253.55.211:2380"],"advertise-client-urls":["https://162.253.55.211:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.211:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-01T19:14:50.663008Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-01T19:14:51.244931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f is starting a new election at term 1"}
{"level":"info","ts":"2026-10-01T19:14:51.244994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-01T19:14:51.245015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f received MsgPreVoteResp from 931f6a422b4c426f at term 1"}
{"level":"info","ts":"2026-10-01T19:14:51.245033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f became candidate at term 2"}
{"level":"info","ts":"2026-10-01T19:14:51.245044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f received MsgVoteResp from 931f6a422b4c426f at term 2"}
{"level":"info","ts":"2026-10-01T19:14:51.245059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"931f6a422b4c426f became leader at term 2"}
{"level":"info","ts":"2026-10-01T19:14:51.245074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 931f6a422b4c426f elected leader 931f6a422b4c426f at term 2"}
{"level":"info","ts":"2026-10-01T19:14:51.246642Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-01T19:14:51.247888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-01T19:14:51.247881Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"931f6a422b4c426f","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.211:2379]}","request-path":"/0/members/931f6a422b4c426f/attributes","cluster-id":"8a95cf5058d193ed","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-01T19:14:51.24797Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-01T19:14:51.248355Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-01T19:14:51.24844Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-01T19:14:51.248619Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8a95cf5058d193ed","local-member-id":"931f6a422b4c426f","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-01T19:14:51.248772Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-01T19:14:51.248824Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-01T19:14:51.250842Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-01T19:14:51.251465Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.211:2379"}
{"level":"info","ts":"2026-10-01T19:14:53.830392Z","caller":"traceutil/trace.go:171","msg":"trace[1171823560] linearizableReadLoop","detail":"{readStateIndex:116; appliedIndex:115; }","duration":"104.432186ms","start":"2026-10-01T19:14:53.725937Z","end":"2026-10-01T19:14:53.830369Z","steps":["trace[1171823560] 'read index received'  (duration: 104.242482ms)","trace[1171823560] 'applied index is now lower than readState.Index'  (duration: 188.734µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:14:53.830498Z","caller":"traceutil/trace.go:171","msg":"trace[1959222090] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"106.35523ms","start":"2026-10-01T19:14:53.724116Z","end":"2026-10-01T19:14:53.830471Z","steps":["trace[1959222090] 'process raft request'  (duration: 106.122765ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:14:53.830705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.627001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-10-01T19:14:53.830842Z","caller":"traceutil/trace.go:171","msg":"trace[272752366] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:110; }","duration":"104.940188ms","start":"2026-10-01T19:14:53.725886Z","end":"2026-10-01T19:14:53.830826Z","steps":["trace[272752366] 'agreement among raft nodes before linearized reading'  (duration: 104.58929ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:15:28.524808Z","caller":"traceutil/trace.go:171","msg":"trace[1659193545] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"103.554057ms","start":"2026-10-01T19:15:28.421189Z","end":"2026-10-01T19:15:28.524743Z","steps":["trace[1659193545] 'process raft request'  (duration: 63.8872ms)","trace[1659193545] 'compare'  (duration: 35.653128ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:15:33.835833Z","caller":"traceutil/trace.go:171","msg":"trace[1797445093] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"168.691655ms","start":"2026-10-01T19:15:33.667112Z","end":"2026-10-01T19:15:33.835804Z","steps":["trace[1797445093] 'process raft request'  (duration: 168.46973ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:15:34.040518Z","caller":"traceutil/trace.go:171","msg":"trace[1731181580] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"362.109784ms","start":"2026-10-01T19:15:33.678274Z","end":"2026-10-01T19:15:34.040384Z","steps":["trace[1731181580] 'process raft request'  (duration: 275.130247ms)","trace[1731181580] 'compare'  (duration: 86.818143ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:15:34.041181Z","caller":"traceutil/trace.go:171","msg":"trace[287844935] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:644; }","duration":"254.987306ms","start":"2026-10-01T19:15:33.786167Z","end":"2026-10-01T19:15:34.041154Z","steps":["trace[287844935] 'read index received'  (duration: 49.487787ms)","trace[287844935] 'applied index is now lower than readState.Index'  (duration: 205.498279ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:15:34.041208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T19:15:33.678235Z","time spent":"362.367789ms","remote":"127.0.0.1:45586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-vwpt8\" mod_revision:518 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-vwpt8\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-vwpt8\" > >"}
{"level":"info","ts":"2026-10-01T19:15:34.041381Z","caller":"traceutil/trace.go:171","msg":"trace[1355024873] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"293.716252ms","start":"2026-10-01T19:15:33.747648Z","end":"2026-10-01T19:15:34.041365Z","steps":["trace[1355024873] 'process raft request'  (duration: 293.016617ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:15:34.041626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.432477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-01T19:15:34.041706Z","caller":"traceutil/trace.go:171","msg":"trace[2043085962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"255.547339ms","start":"2026-10-01T19:15:33.786137Z","end":"2026-10-01T19:15:34.041684Z","steps":["trace[2043085962] 'agreement among raft nodes before linearized reading'  (duration: 255.412335ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:15:34.524744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.127985ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756622188 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:1006 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-01T19:15:34.524906Z","caller":"traceutil/trace.go:171","msg":"trace[1583023366] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"404.069162ms","start":"2026-10-01T19:15:34.12081Z","end":"2026-10-01T19:15:34.524879Z","steps":["trace[1583023366] 'process raft request'  (duration: 263.499957ms)","trace[1583023366] 'compare'  (duration: 139.88271ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:15:34.524975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T19:15:34.120786Z","time spent":"404.164755ms","remote":"127.0.0.1:45766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:1006 >> failure:<>"}
{"level":"info","ts":"2026-10-01T19:15:36.959893Z","caller":"traceutil/trace.go:171","msg":"trace[821945069] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"108.144049ms","start":"2026-10-01T19:15:36.851724Z","end":"2026-10-01T19:15:36.959868Z","steps":["trace[821945069] 'process raft request'  (duration: 87.407815ms)","trace[821945069] 'compare'  (duration: 20.621091ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:15:36.964933Z","caller":"traceutil/trace.go:171","msg":"trace[422609167] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"110.955773ms","start":"2026-10-01T19:15:36.853962Z","end":"2026-10-01T19:15:36.964918Z","steps":["trace[422609167] 'process raft request'  (duration: 110.863991ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:15:50.370555Z","caller":"traceutil/trace.go:171","msg":"trace[1627045232] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"188.090934ms","start":"2026-10-01T19:15:50.182441Z","end":"2026-10-01T19:15:50.370532Z","steps":["trace[1627045232] 'process raft request'  (duration: 187.957521ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:16:19.462922Z","caller":"traceutil/trace.go:171","msg":"trace[310293008] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"129.488ms","start":"2026-10-01T19:16:19.333411Z","end":"2026-10-01T19:16:19.462899Z","steps":["trace[310293008] 'process raft request'  (duration: 129.371537ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:07.70321Z","caller":"traceutil/trace.go:171","msg":"trace[1608691857] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"157.741318ms","start":"2026-10-01T19:17:07.54542Z","end":"2026-10-01T19:17:07.703161Z","steps":["trace[1608691857] 'read index received'  (duration: 157.601035ms)","trace[1608691857] 'applied index is now lower than readState.Index'  (duration: 139.223µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:17:07.703304Z","caller":"traceutil/trace.go:171","msg":"trace[1824415468] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"214.496025ms","start":"2026-10-01T19:17:07.48877Z","end":"2026-10-01T19:17:07.703266Z","steps":["trace[1824415468] 'process raft request'  (duration: 214.25129ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:07.703452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.5431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0a494a2c-640f-4408-adc8-fb51abe3d51f\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-10-01T19:17:07.703493Z","caller":"traceutil/trace.go:171","msg":"trace[544718785] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0a494a2c-640f-4408-adc8-fb51abe3d51f; range_end:; response_count:1; response_revision:1872; }","duration":"120.640952ms","start":"2026-10-01T19:17:07.582841Z","end":"2026-10-01T19:17:07.703482Z","steps":["trace[544718785] 'agreement among raft nodes before linearized reading'  (duration: 120.489399ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:07.703475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.030824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-01T19:17:07.703552Z","caller":"traceutil/trace.go:171","msg":"trace[782694590] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1872; }","duration":"158.148277ms","start":"2026-10-01T19:17:07.545382Z","end":"2026-10-01T19:17:07.70353Z","steps":["trace[782694590] 'agreement among raft nodes before linearized reading'  (duration: 157.930002ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:07.953794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.738243ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756624597 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1850 > 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:16"}
{"level":"info","ts":"2026-10-01T19:17:07.953916Z","caller":"traceutil/trace.go:171","msg":"trace[1176234164] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"168.631757ms","start":"2026-10-01T19:17:07.785264Z","end":"2026-10-01T19:17:07.953896Z","steps":["trace[1176234164] 'read index received'  (duration: 27.587577ms)","trace[1176234164] 'applied index is now lower than readState.Index'  (duration: 141.04232ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:17:07.954043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.78158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-01T19:17:07.954031Z","caller":"traceutil/trace.go:171","msg":"trace[1285764982] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"180.461496ms","start":"2026-10-01T19:17:07.773531Z","end":"2026-10-01T19:17:07.953992Z","steps":["trace[1285764982] 'process raft request'  (duration: 39.422796ms)","trace[1285764982] 'compare'  (duration: 140.57553ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:17:07.954098Z","caller":"traceutil/trace.go:171","msg":"trace[1936894619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"168.873762ms","start":"2026-10-01T19:17:07.785209Z","end":"2026-10-01T19:17:07.954083Z","steps":["trace[1936894619] 'agreement among raft nodes before linearized reading'  (duration: 168.78037ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:21.22563Z","caller":"traceutil/trace.go:171","msg":"trace[904732446] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"130.203053ms","start":"2026-10-01T19:17:21.095407Z","end":"2026-10-01T19:17:21.22561Z","steps":["trace[904732446] 'process raft request'  (duration: 130.0927ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:51.612723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.664234ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-01T19:17:51.61284Z","caller":"traceutil/trace.go:171","msg":"trace[19235694] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2166; }","duration":"116.792247ms","start":"2026-10-01T19:17:51.496031Z","end":"2026-10-01T19:17:51.612823Z","steps":["trace[19235694] 'range keys from in-memory index tree'  (duration: 116.649004ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:51.815519Z","caller":"traceutil/trace.go:171","msg":"trace[397397658] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"181.878579ms","start":"2026-10-01T19:17:51.633619Z","end":"2026-10-01T19:17:51.815498Z","steps":["trace[397397658] 'read index received'  (duration: 181.705015ms)","trace[397397658] 'applied index is now lower than readState.Index'  (duration: 172.704µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:17:51.81561Z","caller":"traceutil/trace.go:171","msg":"trace[2053628004] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"186.005671ms","start":"2026-10-01T19:17:51.62957Z","end":"2026-10-01T19:17:51.815576Z","steps":["trace[2053628004] 'process raft request'  (duration: 185.808376ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:51.815667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.040262ms","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-10-01T19:17:51.815763Z","caller":"traceutil/trace.go:171","msg":"trace[2061790287] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2168; }","duration":"182.141714ms","start":"2026-10-01T19:17:51.633604Z","end":"2026-10-01T19:17:51.815746Z","steps":["trace[2061790287] 'agreement among raft nodes before linearized reading'  (duration: 181.986761ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:52.357722Z","caller":"traceutil/trace.go:171","msg":"trace[455362289] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"121.86463ms","start":"2026-10-01T19:17:52.235827Z","end":"2026-10-01T19:17:52.357692Z","steps":["trace[455362289] 'process raft request'  (duration: 73.886089ms)","trace[455362289] 'compare'  (duration: 47.879689ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:17:58.040661Z","caller":"traceutil/trace.go:171","msg":"trace[348940193] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"193.999021ms","start":"2026-10-01T19:17:57.846633Z","end":"2026-10-01T19:17:58.040632Z","steps":["trace[348940193] 'process raft request'  (duration: 129.169783ms)","trace[348940193] 'compare'  (duration: 64.633002ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:17:58.040796Z","caller":"traceutil/trace.go:171","msg":"trace[1954574261] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2281; }","duration":"123.414014ms","start":"2026-10-01T19:17:57.917333Z","end":"2026-10-01T19:17:58.040747Z","steps":["trace[1954574261] 'read index received'  (duration: 58.569116ms)","trace[1954574261] 'applied index is now lower than readState.Index'  (duration: 64.843098ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:17:58.040818Z","caller":"traceutil/trace.go:171","msg":"trace[1056179913] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"147.446081ms","start":"2026-10-01T19:17:57.893349Z","end":"2026-10-01T19:17:58.040796Z","steps":["trace[1056179913] 'process raft request'  (duration: 147.211536ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:58.040956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.607758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-01T19:17:58.04096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.089123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-01T19:17:58.040989Z","caller":"traceutil/trace.go:171","msg":"trace[647821435] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2202; }","duration":"123.69854ms","start":"2026-10-01T19:17:57.917279Z","end":"2026-10-01T19:17:58.040978Z","steps":["trace[647821435] 'agreement among raft nodes before linearized reading'  (duration: 123.620549ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:58.04101Z","caller":"traceutil/trace.go:171","msg":"trace[1342981495] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2202; }","duration":"104.168595ms","start":"2026-10-01T19:17:57.936827Z","end":"2026-10-01T19:17:58.040996Z","steps":["trace[1342981495] 'agreement among raft nodes before linearized reading'  (duration: 104.081743ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:17:58.532367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.259267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-10-01T19:17:58.532379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.598435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-10-01T19:17:58.532472Z","caller":"traceutil/trace.go:171","msg":"trace[1890120372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2202; }","duration":"294.425101ms","start":"2026-10-01T19:17:58.238029Z","end":"2026-10-01T19:17:58.532454Z","steps":["trace[1890120372] 'range keys from in-memory index tree'  (duration: 294.064703ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:58.532483Z","caller":"traceutil/trace.go:171","msg":"trace[2042896929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2202; }","duration":"152.768119ms","start":"2026-10-01T19:17:58.37969Z","end":"2026-10-01T19:17:58.532459Z","steps":["trace[2042896929] 'range keys from in-memory index tree'  (duration: 152.36358ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:58.730953Z","caller":"traceutil/trace.go:171","msg":"trace[678311421] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"276.733436ms","start":"2026-10-01T19:17:58.454195Z","end":"2026-10-01T19:17:58.730928Z","steps":["trace[678311421] 'process raft request'  (duration: 276.573973ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:58.815059Z","caller":"traceutil/trace.go:171","msg":"trace[834794914] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"278.977966ms","start":"2026-10-01T19:17:58.536059Z","end":"2026-10-01T19:17:58.815037Z","steps":["trace[834794914] 'process raft request'  (duration: 277.146975ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:17:58.815319Z","caller":"traceutil/trace.go:171","msg":"trace[1771587821] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"278.70683ms","start":"2026-10-01T19:17:58.53659Z","end":"2026-10-01T19:17:58.815297Z","steps":["trace[1771587821] 'process raft request'  (duration: 278.376353ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:18:04.182289Z","caller":"traceutil/trace.go:171","msg":"trace[1731022128] linearizableReadLoop","detail":"{readStateIndex:2314; appliedIndex:2313; }","duration":"119.274533ms","start":"2026-10-01T19:18:04.062991Z","end":"2026-10-01T19:18:04.182266Z","steps":["trace[1731022128] 'read index received'  (duration: 119.014857ms)","trace[1731022128] 'applied index is now lower than readState.Index'  (duration: 258.516µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:18:04.182344Z","caller":"traceutil/trace.go:171","msg":"trace[1352775765] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"122.691949ms","start":"2026-10-01T19:18:04.059619Z","end":"2026-10-01T19:18:04.182311Z","steps":["trace[1352775765] 'process raft request'  (duration: 122.482574ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:18:04.182554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.002364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-01T19:18:04.182599Z","caller":"traceutil/trace.go:171","msg":"trace[945678538] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2232; }","duration":"101.111147ms","start":"2026-10-01T19:18:04.081474Z","end":"2026-10-01T19:18:04.182585Z","steps":["trace[945678538] 'agreement among raft nodes before linearized reading'  (duration: 100.936983ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:18:04.182569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.566649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-10-01T19:18:04.182656Z","caller":"traceutil/trace.go:171","msg":"trace[507860194] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2232; }","duration":"119.706622ms","start":"2026-10-01T19:18:04.062929Z","end":"2026-10-01T19:18:04.182635Z","steps":["trace[507860194] 'agreement among raft nodes before linearized reading'  (duration: 119.429146ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:19:24.007001Z","caller":"traceutil/trace.go:171","msg":"trace[1746255985] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"123.259295ms","start":"2026-10-01T19:19:23.883712Z","end":"2026-10-01T19:19:24.006971Z","steps":["trace[1746255985] 'process raft request'  (duration: 123.110912ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:22:31.805884Z","caller":"traceutil/trace.go:171","msg":"trace[1447346206] transaction","detail":"{read_only:false; response_revision:4051; number_of_response:1; }","duration":"127.960823ms","start":"2026-10-01T19:22:31.677892Z","end":"2026-10-01T19:22:31.805853Z","steps":["trace[1447346206] 'process raft request'  (duration: 127.772839ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:03.007482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.075943ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756632601 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5123 > 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:16"}
{"level":"info","ts":"2026-10-01T19:24:03.007698Z","caller":"traceutil/trace.go:171","msg":"trace[219000785] linearizableReadLoop","detail":"{readStateIndex:5435; appliedIndex:5434; }","duration":"271.645276ms","start":"2026-10-01T19:24:02.73601Z","end":"2026-10-01T19:24:03.007655Z","steps":["trace[219000785] 'read index received'  (duration: 164.290657ms)","trace[219000785] 'applied index is now lower than readState.Index'  (duration: 107.352889ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:24:03.007703Z","caller":"traceutil/trace.go:171","msg":"trace[2119141169] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"272.107606ms","start":"2026-10-01T19:24:02.735562Z","end":"2026-10-01T19:24:03.00767Z","steps":["trace[2119141169] 'process raft request'  (duration: 164.753647ms)","trace[2119141169] 'compare'  (duration: 106.636584ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:24:03.007971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.952963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62980"}
{"level":"info","ts":"2026-10-01T19:24:03.008015Z","caller":"traceutil/trace.go:171","msg":"trace[1019107851] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:5239; }","duration":"272.010034ms","start":"2026-10-01T19:24:02.735995Z","end":"2026-10-01T19:24:03.008005Z","steps":["trace[1019107851] 'agreement among raft nodes before linearized reading'  (duration: 271.752088ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:03.050757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.803076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-10-01T19:24:03.050753Z","caller":"traceutil/trace.go:171","msg":"trace[449268188] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"314.580041ms","start":"2026-10-01T19:24:02.736078Z","end":"2026-10-01T19:24:03.050658Z","steps":["trace[449268188] 'process raft request'  (duration: 314.297585ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:03.050849Z","caller":"traceutil/trace.go:171","msg":"trace[1137695589] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5240; }","duration":"137.881088ms","start":"2026-10-01T19:24:02.912929Z","end":"2026-10-01T19:24:03.05081Z","steps":["trace[1137695589] 'agreement among raft nodes before linearized reading'  (duration: 137.681554ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:03.050948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T19:24:02.736067Z","time spent":"314.780537ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5124 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-10-01T19:24:06.853445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.413355ms","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-10-01T19:24:06.853532Z","caller":"traceutil/trace.go:171","msg":"trace[1987114609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5323; }","duration":"109.557138ms","start":"2026-10-01T19:24:06.743958Z","end":"2026-10-01T19:24:06.853515Z","steps":["trace[1987114609] 'range keys from in-memory index tree'  (duration: 109.20648ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:06.853528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.899518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-46fa43bf-621e-45f1-a88c-414c183af040\" ","response":"range_response_count:1 size:1275"}
{"level":"info","ts":"2026-10-01T19:24:06.853609Z","caller":"traceutil/trace.go:171","msg":"trace[155036600] range","detail":"{range_begin:/registry/persistentvolumes/pvc-46fa43bf-621e-45f1-a88c-414c183af040; range_end:; response_count:1; response_revision:5323; }","duration":"235.000701ms","start":"2026-10-01T19:24:06.618585Z","end":"2026-10-01T19:24:06.853585Z","steps":["trace[155036600] 'range keys from in-memory index tree'  (duration: 234.756365ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:07.070715Z","caller":"traceutil/trace.go:171","msg":"trace[2028884728] linearizableReadLoop","detail":"{readStateIndex:5525; appliedIndex:5524; }","duration":"146.345298ms","start":"2026-10-01T19:24:06.924346Z","end":"2026-10-01T19:24:07.070691Z","steps":["trace[2028884728] 'read index received'  (duration: 102.189415ms)","trace[2028884728] 'applied index is now lower than readState.Index'  (duration: 44.154632ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:24:07.07075Z","caller":"traceutil/trace.go:171","msg":"trace[296614097] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"158.818814ms","start":"2026-10-01T19:24:06.911893Z","end":"2026-10-01T19:24:07.070712Z","steps":["trace[296614097] 'process raft request'  (duration: 114.900087ms)","trace[296614097] 'compare'  (duration: 43.737983ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:24:07.070999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.644375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-10-01T19:24:07.071074Z","caller":"traceutil/trace.go:171","msg":"trace[2036859535] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5325; }","duration":"146.766398ms","start":"2026-10-01T19:24:06.924289Z","end":"2026-10-01T19:24:07.071056Z","steps":["trace[2036859535] 'agreement among raft nodes before linearized reading'  (duration: 146.499382ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:19.300773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.993899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-01T19:24:19.301016Z","caller":"traceutil/trace.go:171","msg":"trace[1850149598] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:5523; }","duration":"252.314735ms","start":"2026-10-01T19:24:19.048679Z","end":"2026-10-01T19:24:19.300994Z","steps":["trace[1850149598] 'count revisions from in-memory index tree'  (duration: 251.854646ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:19.301168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.359701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-01T19:24:19.301244Z","caller":"traceutil/trace.go:171","msg":"trace[332985349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5523; }","duration":"161.445942ms","start":"2026-10-01T19:24:19.139782Z","end":"2026-10-01T19:24:19.301228Z","steps":["trace[332985349] 'range keys from in-memory index tree'  (duration: 161.210328ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:19.302531Z","caller":"traceutil/trace.go:171","msg":"trace[1956442236] linearizableReadLoop","detail":"{readStateIndex:5729; appliedIndex:5728; }","duration":"128.95044ms","start":"2026-10-01T19:24:19.173563Z","end":"2026-10-01T19:24:19.302513Z","steps":["trace[1956442236] 'read index received'  (duration: 128.817047ms)","trace[1956442236] 'applied index is now lower than readState.Index'  (duration: 132.373µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:24:19.302689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.130874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r8mrp\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-10-01T19:24:19.302723Z","caller":"traceutil/trace.go:171","msg":"trace[2101753334] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r8mrp; range_end:; response_count:1; response_revision:5524; }","duration":"129.209026ms","start":"2026-10-01T19:24:19.173504Z","end":"2026-10-01T19:24:19.302713Z","steps":["trace[2101753334] 'agreement among raft nodes before linearized reading'  (duration: 129.104674ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:19.302712Z","caller":"traceutil/trace.go:171","msg":"trace[857340414] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"142.310147ms","start":"2026-10-01T19:24:19.160319Z","end":"2026-10-01T19:24:19.302629Z","steps":["trace[857340414] 'process raft request'  (duration: 142.064832ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:19.302883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.940558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-01T19:24:19.302979Z","caller":"traceutil/trace.go:171","msg":"trace[1317833244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5524; }","duration":"128.077291ms","start":"2026-10-01T19:24:19.174875Z","end":"2026-10-01T19:24:19.302952Z","steps":["trace[1317833244] 'agreement among raft nodes before linearized reading'  (duration: 127.779395ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:37.723728Z","caller":"traceutil/trace.go:171","msg":"trace[1039303957] transaction","detail":"{read_only:false; response_revision:5828; number_of_response:1; }","duration":"130.770818ms","start":"2026-10-01T19:24:37.592921Z","end":"2026-10-01T19:24:37.723692Z","steps":["trace[1039303957] 'process raft request'  (duration: 91.790449ms)","trace[1039303957] 'compare'  (duration: 38.681072ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:24:37.723791Z","caller":"traceutil/trace.go:171","msg":"trace[368597931] linearizableReadLoop","detail":"{readStateIndex:6043; appliedIndex:6038; }","duration":"119.884195ms","start":"2026-10-01T19:24:37.603882Z","end":"2026-10-01T19:24:37.723767Z","steps":["trace[368597931] 'read index received'  (duration: 80.876225ms)","trace[368597931] 'applied index is now lower than readState.Index'  (duration: 39.0068ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:24:37.723899Z","caller":"traceutil/trace.go:171","msg":"trace[742047747] transaction","detail":"{read_only:false; response_revision:5831; number_of_response:1; }","duration":"124.529058ms","start":"2026-10-01T19:24:37.599342Z","end":"2026-10-01T19:24:37.723871Z","steps":["trace[742047747] 'process raft request'  (duration: 124.340884ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:37.723995Z","caller":"traceutil/trace.go:171","msg":"trace[169158074] transaction","detail":"{read_only:false; response_revision:5829; number_of_response:1; }","duration":"124.945807ms","start":"2026-10-01T19:24:37.599038Z","end":"2026-10-01T19:24:37.723984Z","steps":["trace[169158074] 'process raft request'  (duration: 124.497168ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:24:37.72405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.13952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b44a5b68-1cc6-4c72-8f81-4fb5bb6dad96\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-10-01T19:24:37.723895Z","caller":"traceutil/trace.go:171","msg":"trace[1705406512] transaction","detail":"{read_only:false; response_revision:5830; number_of_response:1; }","duration":"124.59572ms","start":"2026-10-01T19:24:37.599269Z","end":"2026-10-01T19:24:37.723865Z","steps":["trace[1705406512] 'process raft request'  (duration: 124.375285ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:37.724079Z","caller":"traceutil/trace.go:171","msg":"trace[1216404676] transaction","detail":"{read_only:false; response_revision:5832; number_of_response:1; }","duration":"124.12174ms","start":"2026-10-01T19:24:37.59992Z","end":"2026-10-01T19:24:37.724042Z","steps":["trace[1216404676] 'process raft request'  (duration: 123.805683ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:37.724111Z","caller":"traceutil/trace.go:171","msg":"trace[1459592105] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b44a5b68-1cc6-4c72-8f81-4fb5bb6dad96; range_end:; response_count:1; response_revision:5832; }","duration":"120.235612ms","start":"2026-10-01T19:24:37.603859Z","end":"2026-10-01T19:24:37.724095Z","steps":["trace[1459592105] 'agreement among raft nodes before linearized reading'  (duration: 120.019447ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:24:51.288135Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3008}
{"level":"info","ts":"2026-10-01T19:24:51.371866Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3008,"took":"82.626314ms","hash":4248315037,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":30208000,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-01T19:24:51.371946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4248315037,"revision":3008,"compact-revision":-1}
{"level":"info","ts":"2026-10-01T19:29:51.294492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5935}
{"level":"info","ts":"2026-10-01T19:29:51.395777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5935,"took":"99.191737ms","hash":1125589300,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":25927680,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-01T19:29:51.395917Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1125589300,"revision":5935,"compact-revision":3008}
{"level":"warn","ts":"2026-10-01T19:30:53.199921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.444581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-10-01T19:30:53.200073Z","caller":"traceutil/trace.go:171","msg":"trace[1713396828] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8621; }","duration":"157.654334ms","start":"2026-10-01T19:30:53.042397Z","end":"2026-10-01T19:30:53.200052Z","steps":["trace[1713396828] 'range keys from in-memory index tree'  (duration: 156.829276ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:30:53.33378Z","caller":"traceutil/trace.go:171","msg":"trace[1333777821] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"127.961019ms","start":"2026-10-01T19:30:53.205788Z","end":"2026-10-01T19:30:53.333749Z","steps":["trace[1333777821] 'process raft request'  (duration: 127.784136ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:05.06464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.96516ms","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:7"}
{"level":"info","ts":"2026-10-01T19:31:05.064766Z","caller":"traceutil/trace.go:171","msg":"trace[44891771] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8685; }","duration":"217.146285ms","start":"2026-10-01T19:31:04.847597Z","end":"2026-10-01T19:31:05.064743Z","steps":["trace[44891771] 'count revisions from in-memory index tree'  (duration: 216.827328ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:31:05.086403Z","caller":"traceutil/trace.go:171","msg":"trace[1175906890] transaction","detail":"{read_only:false; response_revision:8686; number_of_response:1; }","duration":"201.32881ms","start":"2026-10-01T19:31:04.88504Z","end":"2026-10-01T19:31:05.086369Z","steps":["trace[1175906890] 'process raft request'  (duration: 201.113346ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:31:05.488839Z","caller":"traceutil/trace.go:171","msg":"trace[699219827] transaction","detail":"{read_only:false; response_revision:8687; number_of_response:1; }","duration":"100.949467ms","start":"2026-10-01T19:31:05.387849Z","end":"2026-10-01T19:31:05.488798Z","steps":["trace[699219827] 'process raft request'  (duration: 100.503327ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:05.712565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.670073ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756641442 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8678 > 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:16"}
{"level":"info","ts":"2026-10-01T19:31:05.712726Z","caller":"traceutil/trace.go:171","msg":"trace[1582348842] transaction","detail":"{read_only:false; response_revision:8688; number_of_response:1; }","duration":"217.960223ms","start":"2026-10-01T19:31:05.494736Z","end":"2026-10-01T19:31:05.712696Z","steps":["trace[1582348842] 'process raft request'  (duration: 102.685556ms)","trace[1582348842] 'compare'  (duration: 114.353716ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:31:05.748989Z","caller":"traceutil/trace.go:171","msg":"trace[29362755] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"254.161682ms","start":"2026-10-01T19:31:05.494802Z","end":"2026-10-01T19:31:05.748963Z","steps":["trace[29362755] 'process raft request'  (duration: 253.976377ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:31:05.749172Z","caller":"traceutil/trace.go:171","msg":"trace[1036857110] linearizableReadLoop","detail":"{readStateIndex:8995; appliedIndex:8992; }","duration":"178.778017ms","start":"2026-10-01T19:31:05.570346Z","end":"2026-10-01T19:31:05.749124Z","steps":["trace[1036857110] 'read index received'  (duration: 27.011995ms)","trace[1036857110] 'applied index is now lower than readState.Index'  (duration: 151.763662ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:31:05.749216Z","caller":"traceutil/trace.go:171","msg":"trace[1452896444] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"254.367796ms","start":"2026-10-01T19:31:05.494802Z","end":"2026-10-01T19:31:05.749169Z","steps":["trace[1452896444] 'process raft request'  (duration: 254.114351ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:05.749651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.267278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-10-01T19:31:05.749778Z","caller":"traceutil/trace.go:171","msg":"trace[122002972] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8690; }","duration":"179.416191ms","start":"2026-10-01T19:31:05.570328Z","end":"2026-10-01T19:31:05.749744Z","steps":["trace[122002972] 'agreement among raft nodes before linearized reading'  (duration: 178.972341ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:31:05.777788Z","caller":"traceutil/trace.go:171","msg":"trace[737416896] transaction","detail":"{read_only:false; response_revision:8691; number_of_response:1; }","duration":"106.312866ms","start":"2026-10-01T19:31:05.671444Z","end":"2026-10-01T19:31:05.777757Z","steps":["trace[737416896] 'process raft request'  (duration: 106.131022ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:05.778015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.382175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r8mrp\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-10-01T19:31:05.778096Z","caller":"traceutil/trace.go:171","msg":"trace[15480297] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r8mrp; range_end:; response_count:1; response_revision:8691; }","duration":"134.546818ms","start":"2026-10-01T19:31:05.64353Z","end":"2026-10-01T19:31:05.778077Z","steps":["trace[15480297] 'agreement among raft nodes before linearized reading'  (duration: 134.264181ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:05.778093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.455396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-01T19:31:05.778177Z","caller":"traceutil/trace.go:171","msg":"trace[1502203466] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8691; }","duration":"151.594209ms","start":"2026-10-01T19:31:05.626562Z","end":"2026-10-01T19:31:05.778156Z","steps":["trace[1502203466] 'agreement among raft nodes before linearized reading'  (duration: 151.337573ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:31:31.192204Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023cf.wal"}
{"level":"info","ts":"2026-10-01T19:31:35.873181Z","caller":"traceutil/trace.go:171","msg":"trace[1923182538] transaction","detail":"{read_only:false; response_revision:8902; number_of_response:1; }","duration":"267.223824ms","start":"2026-10-01T19:31:35.60592Z","end":"2026-10-01T19:31:35.873144Z","steps":["trace[1923182538] 'process raft request'  (duration: 267.015108ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:36.066283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.201204ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756642100 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8893 > 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:16"}
{"level":"info","ts":"2026-10-01T19:31:36.066636Z","caller":"traceutil/trace.go:171","msg":"trace[1458055963] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"187.848899ms","start":"2026-10-01T19:31:35.878764Z","end":"2026-10-01T19:31:36.066613Z","steps":["trace[1458055963] 'process raft request'  (duration: 51.214104ms)","trace[1458055963] 'compare'  (duration: 135.896418ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:31:36.066668Z","caller":"traceutil/trace.go:171","msg":"trace[1232242572] linearizableReadLoop","detail":"{readStateIndex:9218; appliedIndex:9216; }","duration":"150.820702ms","start":"2026-10-01T19:31:35.915826Z","end":"2026-10-01T19:31:36.066647Z","steps":["trace[1232242572] 'read index received'  (duration: 14.166017ms)","trace[1232242572] 'applied index is now lower than readState.Index'  (duration: 136.653645ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:31:36.066778Z","caller":"traceutil/trace.go:171","msg":"trace[80093155] transaction","detail":"{read_only:false; response_revision:8904; number_of_response:1; }","duration":"176.738971ms","start":"2026-10-01T19:31:35.890007Z","end":"2026-10-01T19:31:36.066746Z","steps":["trace[80093155] 'process raft request'  (duration: 176.416064ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:36.066972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.826846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-01T19:31:36.067004Z","caller":"traceutil/trace.go:171","msg":"trace[1297417438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8904; }","duration":"148.897308ms","start":"2026-10-01T19:31:35.918098Z","end":"2026-10-01T19:31:36.066995Z","steps":["trace[1297417438] 'agreement among raft nodes before linearized reading'  (duration: 148.781336ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:36.067134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.295912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-01T19:31:36.067182Z","caller":"traceutil/trace.go:171","msg":"trace[1802977073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8904; }","duration":"151.383634ms","start":"2026-10-01T19:31:35.915786Z","end":"2026-10-01T19:31:36.06717Z","steps":["trace[1802977073] 'agreement among raft nodes before linearized reading'  (duration: 151.042367ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:31:36.069373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.15838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-01T19:31:36.06951Z","caller":"traceutil/trace.go:171","msg":"trace[966310802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8904; }","duration":"121.384364ms","start":"2026-10-01T19:31:35.948097Z","end":"2026-10-01T19:31:36.069481Z","steps":["trace[966310802] 'agreement among raft nodes before linearized reading'  (duration: 118.900998ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:31:48.101354Z","caller":"traceutil/trace.go:171","msg":"trace[382380605] transaction","detail":"{read_only:false; response_revision:8967; number_of_response:1; }","duration":"187.013371ms","start":"2026-10-01T19:31:47.914275Z","end":"2026-10-01T19:31:48.101288Z","steps":["trace[382380605] 'process raft request'  (duration: 183.306398ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:32:53.952846Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"931f6a422b4c426f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-01T19:32:53.962105Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-01T19:32:53.962267Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"warn","ts":"2026-10-01T19:33:17.980759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.074803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-01T19:33:17.980942Z","caller":"traceutil/trace.go:171","msg":"trace[391608403] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:9828; }","duration":"107.344809ms","start":"2026-10-01T19:33:17.873573Z","end":"2026-10-01T19:33:17.980918Z","steps":["trace[391608403] 'count revisions from in-memory index tree'  (duration: 106.882117ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:33:17.980761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.706125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-01T19:33:17.981276Z","caller":"traceutil/trace.go:171","msg":"trace[312820604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9828; }","duration":"193.123335ms","start":"2026-10-01T19:33:17.787971Z","end":"2026-10-01T19:33:17.981094Z","steps":["trace[312820604] 'range keys from in-memory index tree'  (duration: 191.831936ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:34:51.306606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8095}
{"level":"info","ts":"2026-10-01T19:34:51.37559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8095,"took":"66.23422ms","hash":1467224088,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":28037120,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-01T19:34:51.375662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1467224088,"revision":8095,"compact-revision":5935}
{"level":"info","ts":"2026-10-01T19:39:51.313266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10456}
{"level":"info","ts":"2026-10-01T19:39:51.40264Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10456,"took":"86.637419ms","hash":3853383298,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":26304512,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-01T19:39:51.402778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3853383298,"revision":10456,"compact-revision":8095}
{"level":"info","ts":"2026-10-01T19:44:51.321003Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12632}
{"level":"info","ts":"2026-10-01T19:44:51.41066Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12632,"took":"85.724968ms","hash":2581294789,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":27938816,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-01T19:44:51.410744Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2581294789,"revision":12632,"compact-revision":10456}
{"level":"info","ts":"2026-10-01T19:45:06.904485Z","caller":"traceutil/trace.go:171","msg":"trace[1660918358] linearizableReadLoop","detail":"{readStateIndex:15262; appliedIndex:15261; }","duration":"295.353566ms","start":"2026-10-01T19:45:06.609074Z","end":"2026-10-01T19:45:06.904428Z","steps":["trace[1660918358] 'read index received'  (duration: 198.890038ms)","trace[1660918358] 'applied index is now lower than readState.Index'  (duration: 96.460938ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:45:06.904688Z","caller":"traceutil/trace.go:171","msg":"trace[1691056716] transaction","detail":"{read_only:false; response_revision:14755; number_of_response:1; }","duration":"295.670643ms","start":"2026-10-01T19:45:06.608983Z","end":"2026-10-01T19:45:06.904653Z","steps":["trace[1691056716] 'process raft request'  (duration: 199.053172ms)","trace[1691056716] 'compare'  (duration: 96.000178ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:45:06.904975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.863767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-01T19:45:06.905042Z","caller":"traceutil/trace.go:171","msg":"trace[1146263348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14755; }","duration":"296.024372ms","start":"2026-10-01T19:45:06.609Z","end":"2026-10-01T19:45:06.905024Z","steps":["trace[1146263348] 'agreement among raft nodes before linearized reading'  (duration: 295.735305ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:45:06.905399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.269897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-01T19:45:06.905458Z","caller":"traceutil/trace.go:171","msg":"trace[2013366721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14755; }","duration":"296.366459ms","start":"2026-10-01T19:45:06.609077Z","end":"2026-10-01T19:45:06.905444Z","steps":["trace[2013366721] 'agreement among raft nodes before linearized reading'  (duration: 296.169724ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:45:06.905636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.323758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-01T19:45:06.906504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.834241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r8mrp\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-10-01T19:45:06.906515Z","caller":"traceutil/trace.go:171","msg":"trace[22148665] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14755; }","duration":"120.177457ms","start":"2026-10-01T19:45:06.786269Z","end":"2026-10-01T19:45:06.906447Z","steps":["trace[22148665] 'agreement among raft nodes before linearized reading'  (duration: 119.322098ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:45:06.906594Z","caller":"traceutil/trace.go:171","msg":"trace[184892236] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r8mrp; range_end:; response_count:1; response_revision:14755; }","duration":"187.983266ms","start":"2026-10-01T19:45:06.718594Z","end":"2026-10-01T19:45:06.906578Z","steps":["trace[184892236] 'agreement among raft nodes before linearized reading'  (duration: 187.77555ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:45:06.906188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.19802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-10-01T19:45:06.906852Z","caller":"traceutil/trace.go:171","msg":"trace[96148563] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14755; }","duration":"163.903136ms","start":"2026-10-01T19:45:06.742917Z","end":"2026-10-01T19:45:06.90682Z","steps":["trace[96148563] 'agreement among raft nodes before linearized reading'  (duration: 163.115168ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:46:12.771772Z","caller":"traceutil/trace.go:171","msg":"trace[2098293494] transaction","detail":"{read_only:false; response_revision:15313; number_of_response:1; }","duration":"127.354729ms","start":"2026-10-01T19:46:12.644378Z","end":"2026-10-01T19:46:12.771733Z","steps":["trace[2098293494] 'process raft request'  (duration: 80.015729ms)","trace[2098293494] 'compare'  (duration: 47.148505ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:46:13.108687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.36797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-01T19:46:13.108846Z","caller":"traceutil/trace.go:171","msg":"trace[1291004425] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:15313; }","duration":"200.199769ms","start":"2026-10-01T19:46:12.908616Z","end":"2026-10-01T19:46:13.108816Z","steps":["trace[1291004425] 'count revisions from in-memory index tree'  (duration: 199.248828ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:46:13.108969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.136762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-q798z\" ","response":"range_response_count:1 size:20644"}
{"level":"info","ts":"2026-10-01T19:46:13.109096Z","caller":"traceutil/trace.go:171","msg":"trace[1698694139] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-q798z; range_end:; response_count:1; response_revision:15313; }","duration":"118.767037ms","start":"2026-10-01T19:46:12.990299Z","end":"2026-10-01T19:46:13.109066Z","steps":["trace[1698694139] 'range keys from in-memory index tree'  (duration: 117.852906ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:47:41.870635Z","caller":"traceutil/trace.go:171","msg":"trace[1978585284] transaction","detail":"{read_only:false; response_revision:16136; number_of_response:1; }","duration":"154.538766ms","start":"2026-10-01T19:47:41.716045Z","end":"2026-10-01T19:47:41.870583Z","steps":["trace[1978585284] 'process raft request'  (duration: 121.313873ms)","trace[1978585284] 'compare'  (duration: 32.783893ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T19:49:51.327442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14635}
{"level":"info","ts":"2026-10-01T19:49:51.421276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14635,"took":"91.127142ms","hash":2405591111,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":31440896,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-01T19:49:51.421353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2405591111,"revision":14635,"compact-revision":12632}
{"level":"warn","ts":"2026-10-01T19:54:00.80885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.720809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-10-01T19:54:00.808926Z","caller":"traceutil/trace.go:171","msg":"trace[126297067] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18867; }","duration":"179.851032ms","start":"2026-10-01T19:54:00.629059Z","end":"2026-10-01T19:54:00.80891Z","steps":["trace[126297067] 'range keys from in-memory index tree'  (duration: 179.527295ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:54:00.80905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.590867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"info","ts":"2026-10-01T19:54:00.809117Z","caller":"traceutil/trace.go:171","msg":"trace[108100206] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18867; }","duration":"171.668689ms","start":"2026-10-01T19:54:00.63743Z","end":"2026-10-01T19:54:00.809098Z","steps":["trace[108100206] 'range keys from in-memory index tree'  (duration: 171.417253ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:54:00.815302Z","caller":"traceutil/trace.go:171","msg":"trace[1007195301] transaction","detail":"{read_only:false; response_revision:18868; number_of_response:1; }","duration":"147.836844ms","start":"2026-10-01T19:54:00.667304Z","end":"2026-10-01T19:54:00.815141Z","steps":["trace[1007195301] 'process raft request'  (duration: 147.500726ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:54:08.061207Z","caller":"traceutil/trace.go:171","msg":"trace[326183865] transaction","detail":"{read_only:false; response_revision:18917; number_of_response:1; }","duration":"125.80909ms","start":"2026-10-01T19:54:07.93537Z","end":"2026-10-01T19:54:08.06118Z","steps":["trace[326183865] 'process raft request'  (duration: 125.432522ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:54:08.928814Z","caller":"traceutil/trace.go:171","msg":"trace[745726711] transaction","detail":"{read_only:false; response_revision:18921; number_of_response:1; }","duration":"328.37203ms","start":"2026-10-01T19:54:08.600408Z","end":"2026-10-01T19:54:08.92878Z","steps":["trace[745726711] 'process raft request'  (duration: 328.063553ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:54:08.929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T19:54:08.600382Z","time spent":"328.514534ms","remote":"127.0.0.1:45586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20864,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-q798z\" mod_revision:18843 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-q798z\" value_size:20800 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-q798z\" > >"}
{"level":"info","ts":"2026-10-01T19:54:08.928871Z","caller":"traceutil/trace.go:171","msg":"trace[2044922343] linearizableReadLoop","detail":"{readStateIndex:19569; appliedIndex:19568; }","duration":"323.681165ms","start":"2026-10-01T19:54:08.605044Z","end":"2026-10-01T19:54:08.928725Z","steps":["trace[2044922343] 'read index received'  (duration: 323.44983ms)","trace[2044922343] 'applied index is now lower than readState.Index'  (duration: 228.845µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T19:54:08.930109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.026465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946654"}
{"level":"info","ts":"2026-10-01T19:54:08.930213Z","caller":"traceutil/trace.go:171","msg":"trace[1777922195] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:18921; }","duration":"325.151838ms","start":"2026-10-01T19:54:08.605039Z","end":"2026-10-01T19:54:08.930191Z","steps":["trace[1777922195] 'agreement among raft nodes before linearized reading'  (duration: 323.867139ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T19:54:08.930278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T19:54:08.605008Z","time spent":"325.252132ms","remote":"127.0.0.1:45586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":94,"response size":946678,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-10-01T19:54:08.946119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.766811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T19:54:08.946183Z","caller":"traceutil/trace.go:171","msg":"trace[1586568120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18922; }","duration":"159.883724ms","start":"2026-10-01T19:54:08.786284Z","end":"2026-10-01T19:54:08.946168Z","steps":["trace[1586568120] 'agreement among raft nodes before linearized reading'  (duration: 159.769301ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:54:08.946376Z","caller":"traceutil/trace.go:171","msg":"trace[402650169] transaction","detail":"{read_only:false; response_revision:18922; number_of_response:1; }","duration":"103.748735ms","start":"2026-10-01T19:54:08.842577Z","end":"2026-10-01T19:54:08.946326Z","steps":["trace[402650169] 'process raft request'  (duration: 103.309626ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T19:54:49.792586Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"931f6a422b4c426f","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-01T19:54:49.799603Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-01T19:54:49.799711Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-01T19:54:51.339015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17017}
{"level":"info","ts":"2026-10-01T19:54:51.445068Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17017,"took":"102.446817ms","hash":2881920951,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":33038336,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-01T19:54:51.445141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2881920951,"revision":17017,"compact-revision":14635}
{"level":"info","ts":"2026-10-01T19:59:51.352813Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19461}
{"level":"info","ts":"2026-10-01T19:59:51.491702Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19461,"took":"125.208277ms","hash":3782740746,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":30003200,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-01T19:59:51.491786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3782740746,"revision":19461,"compact-revision":17017}
{"level":"info","ts":"2026-10-01T20:00:16.482319Z","caller":"traceutil/trace.go:171","msg":"trace[1272437592] linearizableReadLoop","detail":"{readStateIndex:22536; appliedIndex:22535; }","duration":"129.704617ms","start":"2026-10-01T20:00:16.352596Z","end":"2026-10-01T20:00:16.4823Z","steps":["trace[1272437592] 'read index received'  (duration: 129.547963ms)","trace[1272437592] 'applied index is now lower than readState.Index'  (duration: 155.954µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:00:16.482513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.907932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-01T20:00:16.482493Z","caller":"traceutil/trace.go:171","msg":"trace[532672681] transaction","detail":"{read_only:false; response_revision:21795; number_of_response:1; }","duration":"139.982388ms","start":"2026-10-01T20:00:16.342423Z","end":"2026-10-01T20:00:16.482405Z","steps":["trace[532672681] 'process raft request'  (duration: 139.770453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:00:16.48254Z","caller":"traceutil/trace.go:171","msg":"trace[1315073710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21795; }","duration":"129.985164ms","start":"2026-10-01T20:00:16.352546Z","end":"2026-10-01T20:00:16.482531Z","steps":["trace[1315073710] 'agreement among raft nodes before linearized reading'  (duration: 129.865231ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:00:16.482681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.094855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-10-01T20:00:16.48277Z","caller":"traceutil/trace.go:171","msg":"trace[1224407116] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21795; }","duration":"125.258789ms","start":"2026-10-01T20:00:16.357491Z","end":"2026-10-01T20:00:16.482749Z","steps":["trace[1224407116] 'agreement among raft nodes before linearized reading'  (duration: 124.979782ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:00:23.351522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.005834ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756681948 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:21834 > 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-10-01T20:00:23.351685Z","caller":"traceutil/trace.go:171","msg":"trace[1911327275] transaction","detail":"{read_only:false; response_revision:21844; number_of_response:1; }","duration":"296.880585ms","start":"2026-10-01T20:00:23.054775Z","end":"2026-10-01T20:00:23.351656Z","steps":["trace[1911327275] 'process raft request'  (duration: 162.641146ms)","trace[1911327275] 'compare'  (duration: 133.763989ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:00:23.353287Z","caller":"traceutil/trace.go:171","msg":"trace[480290888] transaction","detail":"{read_only:false; response_revision:21845; number_of_response:1; }","duration":"238.324873ms","start":"2026-10-01T20:00:23.114936Z","end":"2026-10-01T20:00:23.35326Z","steps":["trace[480290888] 'process raft request'  (duration: 237.656567ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:00:24.444428Z","caller":"traceutil/trace.go:171","msg":"trace[1349350481] transaction","detail":"{read_only:false; response_revision:21847; number_of_response:1; }","duration":"154.739129ms","start":"2026-10-01T20:00:24.289662Z","end":"2026-10-01T20:00:24.444401Z","steps":["trace[1349350481] 'process raft request'  (duration: 154.561285ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:04:40.756165Z","caller":"traceutil/trace.go:171","msg":"trace[709616704] transaction","detail":"{read_only:false; response_revision:24410; number_of_response:1; }","duration":"147.556353ms","start":"2026-10-01T20:04:40.608575Z","end":"2026-10-01T20:04:40.756131Z","steps":["trace[709616704] 'process raft request'  (duration: 84.919271ms)","trace[709616704] 'compare'  (duration: 61.764923ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:04:51.359822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21591}
{"level":"info","ts":"2026-10-01T20:04:51.47827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21591,"took":"114.552005ms","hash":1790700836,"current-db-size-bytes":57249792,"current-db-size":"57 MB","current-db-size-in-use-bytes":42811392,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-10-01T20:04:51.478336Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1790700836,"revision":21591,"compact-revision":19461}
{"level":"info","ts":"2026-10-01T20:06:02.323725Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006648.wal"}
{"level":"info","ts":"2026-10-01T20:08:29.882978Z","caller":"traceutil/trace.go:171","msg":"trace[269535288] transaction","detail":"{read_only:false; response_revision:26698; number_of_response:1; }","duration":"174.896346ms","start":"2026-10-01T20:08:29.708047Z","end":"2026-10-01T20:08:29.882943Z","steps":["trace[269535288] 'process raft request'  (duration: 174.658161ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:29.900702Z","caller":"traceutil/trace.go:171","msg":"trace[244791336] transaction","detail":"{read_only:false; response_revision:26699; number_of_response:1; }","duration":"165.240571ms","start":"2026-10-01T20:08:29.735434Z","end":"2026-10-01T20:08:29.900674Z","steps":["trace[244791336] 'process raft request'  (duration: 164.890453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:29.900668Z","caller":"traceutil/trace.go:171","msg":"trace[1886014354] linearizableReadLoop","detail":"{readStateIndex:27578; appliedIndex:27575; }","duration":"114.210007ms","start":"2026-10-01T20:08:29.786429Z","end":"2026-10-01T20:08:29.900639Z","steps":["trace[1886014354] 'read index received'  (duration: 96.321297ms)","trace[1886014354] 'applied index is now lower than readState.Index'  (duration: 17.88741ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:29.900805Z","caller":"traceutil/trace.go:171","msg":"trace[353080647] transaction","detail":"{read_only:false; response_revision:26700; number_of_response:1; }","duration":"137.038898ms","start":"2026-10-01T20:08:29.76374Z","end":"2026-10-01T20:08:29.900778Z","steps":["trace[353080647] 'process raft request'  (duration: 136.831993ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:29.900943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.487964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:29.901034Z","caller":"traceutil/trace.go:171","msg":"trace[721758995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26700; }","duration":"114.648367ms","start":"2026-10-01T20:08:29.786368Z","end":"2026-10-01T20:08:29.901017Z","steps":["trace[721758995] 'agreement among raft nodes before linearized reading'  (duration: 114.476593ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.441275Z","caller":"traceutil/trace.go:171","msg":"trace[469738540] linearizableReadLoop","detail":"{readStateIndex:27623; appliedIndex:27622; }","duration":"228.037646ms","start":"2026-10-01T20:08:35.213208Z","end":"2026-10-01T20:08:35.441246Z","steps":["trace[469738540] 'read index received'  (duration: 227.74704ms)","trace[469738540] 'applied index is now lower than readState.Index'  (duration: 289.206µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:35.441635Z","caller":"traceutil/trace.go:171","msg":"trace[575324129] transaction","detail":"{read_only:false; response_revision:26742; number_of_response:1; }","duration":"311.932995ms","start":"2026-10-01T20:08:35.129686Z","end":"2026-10-01T20:08:35.441619Z","steps":["trace[575324129] 'process raft request'  (duration: 311.370143ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:35.441786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:35.129657Z","time spent":"312.011618ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26720 > 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-10-01T20:08:35.44191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.662441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-01T20:08:35.442007Z","caller":"traceutil/trace.go:171","msg":"trace[12186675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26742; }","duration":"228.825965ms","start":"2026-10-01T20:08:35.213159Z","end":"2026-10-01T20:08:35.441984Z","steps":["trace[12186675] 'agreement among raft nodes before linearized reading'  (duration: 228.520368ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:35.442192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.287462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-01T20:08:35.442246Z","caller":"traceutil/trace.go:171","msg":"trace[1324450057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26742; }","duration":"190.377734ms","start":"2026-10-01T20:08:35.251854Z","end":"2026-10-01T20:08:35.442232Z","steps":["trace[1324450057] 'agreement among raft nodes before linearized reading'  (duration: 189.837701ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:35.442313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.519899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-01T20:08:35.442539Z","caller":"traceutil/trace.go:171","msg":"trace[1671994302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26742; }","duration":"178.752863ms","start":"2026-10-01T20:08:35.263719Z","end":"2026-10-01T20:08:35.442472Z","steps":["trace[1671994302] 'agreement among raft nodes before linearized reading'  (duration: 178.394855ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.586869Z","caller":"traceutil/trace.go:171","msg":"trace[617339154] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"136.456776ms","start":"2026-10-01T20:08:35.450379Z","end":"2026-10-01T20:08:35.586836Z","steps":["trace[617339154] 'process raft request'  (duration: 136.21849ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.587004Z","caller":"traceutil/trace.go:171","msg":"trace[1002035873] transaction","detail":"{read_only:false; response_revision:26745; number_of_response:1; }","duration":"136.597399ms","start":"2026-10-01T20:08:35.450385Z","end":"2026-10-01T20:08:35.586982Z","steps":["trace[1002035873] 'process raft request'  (duration: 136.252831ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.587159Z","caller":"traceutil/trace.go:171","msg":"trace[1682238760] transaction","detail":"{read_only:false; response_revision:26746; number_of_response:1; }","duration":"111.137579ms","start":"2026-10-01T20:08:35.476014Z","end":"2026-10-01T20:08:35.587152Z","steps":["trace[1682238760] 'process raft request'  (duration: 110.645848ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.587229Z","caller":"traceutil/trace.go:171","msg":"trace[712274448] transaction","detail":"{read_only:false; response_revision:26747; number_of_response:1; }","duration":"109.344259ms","start":"2026-10-01T20:08:35.477879Z","end":"2026-10-01T20:08:35.587223Z","steps":["trace[712274448] 'process raft request'  (duration: 108.802607ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.587279Z","caller":"traceutil/trace.go:171","msg":"trace[1719772893] transaction","detail":"{read_only:false; response_revision:26743; number_of_response:1; }","duration":"137.181452ms","start":"2026-10-01T20:08:35.450085Z","end":"2026-10-01T20:08:35.587267Z","steps":["trace[1719772893] 'process raft request'  (duration: 135.27704ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:35.819183Z","caller":"traceutil/trace.go:171","msg":"trace[1537935321] transaction","detail":"{read_only:false; response_revision:26748; number_of_response:1; }","duration":"227.407403ms","start":"2026-10-01T20:08:35.591699Z","end":"2026-10-01T20:08:35.819107Z","steps":["trace[1537935321] 'process raft request'  (duration: 227.102016ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:36.046643Z","caller":"traceutil/trace.go:171","msg":"trace[1458730213] transaction","detail":"{read_only:false; response_revision:26749; number_of_response:1; }","duration":"123.871814ms","start":"2026-10-01T20:08:35.922736Z","end":"2026-10-01T20:08:36.046608Z","steps":["trace[1458730213] 'process raft request'  (duration: 123.713981ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:36.06548Z","caller":"traceutil/trace.go:171","msg":"trace[228373208] transaction","detail":"{read_only:false; response_revision:26751; number_of_response:1; }","duration":"131.195059ms","start":"2026-10-01T20:08:35.934225Z","end":"2026-10-01T20:08:36.06542Z","steps":["trace[228373208] 'process raft request'  (duration: 131.139158ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:36.065583Z","caller":"traceutil/trace.go:171","msg":"trace[1103989089] transaction","detail":"{read_only:false; response_revision:26750; number_of_response:1; }","duration":"140.744561ms","start":"2026-10-01T20:08:35.924795Z","end":"2026-10-01T20:08:36.06554Z","steps":["trace[1103989089] 'process raft request'  (duration: 140.351333ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:36.871667Z","caller":"traceutil/trace.go:171","msg":"trace[931995198] transaction","detail":"{read_only:false; response_revision:26753; number_of_response:1; }","duration":"150.635333ms","start":"2026-10-01T20:08:36.720993Z","end":"2026-10-01T20:08:36.871629Z","steps":["trace[931995198] 'process raft request'  (duration: 150.403418ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:36.877473Z","caller":"traceutil/trace.go:171","msg":"trace[710264519] transaction","detail":"{read_only:false; response_revision:26754; number_of_response:1; }","duration":"104.222384ms","start":"2026-10-01T20:08:36.773218Z","end":"2026-10-01T20:08:36.87744Z","steps":["trace[710264519] 'process raft request'  (duration: 104.000099ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:37.61441Z","caller":"traceutil/trace.go:171","msg":"trace[722448586] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"159.336158ms","start":"2026-10-01T20:08:37.455045Z","end":"2026-10-01T20:08:37.614381Z","steps":["trace[722448586] 'process raft request'  (duration: 159.160485ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:37.721708Z","caller":"traceutil/trace.go:171","msg":"trace[1114679506] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"128.163429ms","start":"2026-10-01T20:08:37.593517Z","end":"2026-10-01T20:08:37.72168Z","steps":["trace[1114679506] 'process raft request'  (duration: 127.965385ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:37.721911Z","caller":"traceutil/trace.go:171","msg":"trace[2108538739] linearizableReadLoop","detail":"{readStateIndex:27638; appliedIndex:27636; }","duration":"127.091196ms","start":"2026-10-01T20:08:37.594785Z","end":"2026-10-01T20:08:37.721876Z","steps":["trace[2108538739] 'read index received'  (duration: 19.535478ms)","trace[2108538739] 'applied index is now lower than readState.Index'  (duration: 107.552918ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:37.722043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.24286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-01T20:08:37.721987Z","caller":"traceutil/trace.go:171","msg":"trace[752390064] transaction","detail":"{read_only:false; response_revision:26758; number_of_response:1; }","duration":"116.764804ms","start":"2026-10-01T20:08:37.605134Z","end":"2026-10-01T20:08:37.721899Z","steps":["trace[752390064] 'process raft request'  (duration: 116.507928ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:37.72209Z","caller":"traceutil/trace.go:171","msg":"trace[1404764449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26758; }","duration":"127.363972ms","start":"2026-10-01T20:08:37.594714Z","end":"2026-10-01T20:08:37.722078Z","steps":["trace[1404764449] 'agreement among raft nodes before linearized reading'  (duration: 127.26874ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:37.722235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.305121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-01T20:08:37.722294Z","caller":"traceutil/trace.go:171","msg":"trace[40885241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26758; }","duration":"127.432184ms","start":"2026-10-01T20:08:37.594846Z","end":"2026-10-01T20:08:37.722278Z","steps":["trace[40885241] 'agreement among raft nodes before linearized reading'  (duration: 127.246859ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:37.722272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.070475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-01T20:08:37.722396Z","caller":"traceutil/trace.go:171","msg":"trace[1295321056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26758; }","duration":"127.22433ms","start":"2026-10-01T20:08:37.595147Z","end":"2026-10-01T20:08:37.722371Z","steps":["trace[1295321056] 'agreement among raft nodes before linearized reading'  (duration: 126.988384ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:37.944529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.852437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-10-01T20:08:37.944616Z","caller":"traceutil/trace.go:171","msg":"trace[267397373] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26761; }","duration":"121.00477ms","start":"2026-10-01T20:08:37.823589Z","end":"2026-10-01T20:08:37.944594Z","steps":["trace[267397373] 'range keys from in-memory index tree'  (duration: 120.617591ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:38.416517Z","caller":"traceutil/trace.go:171","msg":"trace[1294822902] transaction","detail":"{read_only:false; response_revision:26764; number_of_response:1; }","duration":"344.458145ms","start":"2026-10-01T20:08:38.071623Z","end":"2026-10-01T20:08:38.416081Z","steps":["trace[1294822902] 'process raft request'  (duration: 296.869529ms)","trace[1294822902] 'compare'  (duration: 47.415902ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:38.416668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:38.07159Z","time spent":"345.001286ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26751 > 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":"info","ts":"2026-10-01T20:08:38.513351Z","caller":"traceutil/trace.go:171","msg":"trace[493302842] transaction","detail":"{read_only:false; response_revision:26765; number_of_response:1; }","duration":"441.017458ms","start":"2026-10-01T20:08:38.072305Z","end":"2026-10-01T20:08:38.513322Z","steps":["trace[493302842] 'process raft request'  (duration: 440.383094ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:38.513551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:38.072278Z","time spent":"441.188621ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26750 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-01T20:08:39.739532Z","caller":"traceutil/trace.go:171","msg":"trace[1430327236] linearizableReadLoop","detail":"{readStateIndex:27650; appliedIndex:27649; }","duration":"328.314164ms","start":"2026-10-01T20:08:39.411189Z","end":"2026-10-01T20:08:39.739503Z","steps":["trace[1430327236] 'read index received'  (duration: 328.087349ms)","trace[1430327236] 'applied index is now lower than readState.Index'  (duration: 225.185µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:39.739607Z","caller":"traceutil/trace.go:171","msg":"trace[1678403677] transaction","detail":"{read_only:false; response_revision:26769; number_of_response:1; }","duration":"441.829065ms","start":"2026-10-01T20:08:39.297722Z","end":"2026-10-01T20:08:39.739551Z","steps":["trace[1678403677] 'process raft request'  (duration: 441.543459ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:39.739783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:39.297697Z","time spent":"441.997319ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:26688 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:39.739789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.549479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:39.739892Z","caller":"traceutil/trace.go:171","msg":"trace[1479741515] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:26769; }","duration":"328.734483ms","start":"2026-10-01T20:08:39.411134Z","end":"2026-10-01T20:08:39.739869Z","steps":["trace[1479741515] 'agreement among raft nodes before linearized reading'  (duration: 328.499028ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:39.740166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:39.411109Z","time spent":"329.04203ms","remote":"127.0.0.1:50552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":30,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "}
{"level":"warn","ts":"2026-10-01T20:08:40.021807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.51679ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756694938 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26756 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:08:40.022031Z","caller":"traceutil/trace.go:171","msg":"trace[423570175] linearizableReadLoop","detail":"{readStateIndex:27653; appliedIndex:27650; }","duration":"282.387833ms","start":"2026-10-01T20:08:39.739627Z","end":"2026-10-01T20:08:40.022015Z","steps":["trace[423570175] 'read index received'  (duration: 119.501005ms)","trace[423570175] 'applied index is now lower than readState.Index'  (duration: 162.885858ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:40.022253Z","caller":"traceutil/trace.go:171","msg":"trace[671707122] transaction","detail":"{read_only:false; response_revision:26770; number_of_response:1; }","duration":"400.102611ms","start":"2026-10-01T20:08:39.62211Z","end":"2026-10-01T20:08:40.022213Z","steps":["trace[671707122] 'process raft request'  (duration: 237.084979ms)","trace[671707122] 'compare'  (duration: 161.933647ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:40.022354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:39.622076Z","time spent":"400.232633ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26756 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:40.022455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.968798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-10-01T20:08:40.022501Z","caller":"traceutil/trace.go:171","msg":"trace[846065560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26772; }","duration":"279.049999ms","start":"2026-10-01T20:08:39.743438Z","end":"2026-10-01T20:08:40.022488Z","steps":["trace[846065560] 'agreement among raft nodes before linearized reading'  (duration: 278.869035ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.022597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.574879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:40.02263Z","caller":"traceutil/trace.go:171","msg":"trace[186453072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26772; }","duration":"236.63174ms","start":"2026-10-01T20:08:39.78599Z","end":"2026-10-01T20:08:40.022622Z","steps":["trace[186453072] 'agreement among raft nodes before linearized reading'  (duration: 236.584979ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.022768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.189411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/trunks/\" range_end:\"/registry/openstack.k-orc.cloud/trunks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-01T20:08:40.022811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.952486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-01T20:08:40.022839Z","caller":"traceutil/trace.go:171","msg":"trace[823681707] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/trunks/; range_end:/registry/openstack.k-orc.cloud/trunks0; response_count:0; response_revision:26772; }","duration":"491.310214ms","start":"2026-10-01T20:08:39.531513Z","end":"2026-10-01T20:08:40.022823Z","steps":["trace[823681707] 'agreement among raft nodes before linearized reading'  (duration: 491.179831ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:40.022842Z","caller":"traceutil/trace.go:171","msg":"trace[1197831398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26772; }","duration":"274.015967ms","start":"2026-10-01T20:08:39.748816Z","end":"2026-10-01T20:08:40.022832Z","steps":["trace[1197831398] 'agreement among raft nodes before linearized reading'  (duration: 273.934405ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.02287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:39.531494Z","time spent":"491.370056ms","remote":"127.0.0.1:50576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/trunks/\" range_end:\"/registry/openstack.k-orc.cloud/trunks0\" count_only:true "}
{"level":"info","ts":"2026-10-01T20:08:40.022883Z","caller":"traceutil/trace.go:171","msg":"trace[1779048382] transaction","detail":"{read_only:false; response_revision:26771; number_of_response:1; }","duration":"292.803068ms","start":"2026-10-01T20:08:39.7294Z","end":"2026-10-01T20:08:40.022203Z","steps":["trace[1779048382] 'process raft request'  (duration: 292.50805ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.023049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.651181ms","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-10-01T20:08:40.023101Z","caller":"traceutil/trace.go:171","msg":"trace[1192652212] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26772; }","duration":"278.745803ms","start":"2026-10-01T20:08:39.744345Z","end":"2026-10-01T20:08:40.02309Z","steps":["trace[1192652212] 'agreement among raft nodes before linearized reading'  (duration: 278.62247ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:40.023198Z","caller":"traceutil/trace.go:171","msg":"trace[1567291935] transaction","detail":"{read_only:false; response_revision:26772; number_of_response:1; }","duration":"293.581125ms","start":"2026-10-01T20:08:39.729589Z","end":"2026-10-01T20:08:40.02317Z","steps":["trace[1567291935] 'process raft request'  (duration: 292.384008ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.027356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.337218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274758"}
{"level":"info","ts":"2026-10-01T20:08:40.027412Z","caller":"traceutil/trace.go:171","msg":"trace[269431892] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:26772; }","duration":"318.447781ms","start":"2026-10-01T20:08:39.708951Z","end":"2026-10-01T20:08:40.027399Z","steps":["trace[269431892] 'agreement among raft nodes before linearized reading'  (duration: 314.243887ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.027465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:39.708922Z","time spent":"318.532803ms","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":32,"response size":274782,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"info","ts":"2026-10-01T20:08:40.225781Z","caller":"traceutil/trace.go:171","msg":"trace[1531361601] transaction","detail":"{read_only:false; response_revision:26773; number_of_response:1; }","duration":"196.563472ms","start":"2026-10-01T20:08:40.029183Z","end":"2026-10-01T20:08:40.225746Z","steps":["trace[1531361601] 'process raft request'  (duration: 150.600313ms)","trace[1531361601] 'compare'  (duration: 45.55648ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:40.593987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.825659ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756694946 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26759 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:08:40.59417Z","caller":"traceutil/trace.go:171","msg":"trace[416426690] transaction","detail":"{read_only:false; response_revision:26774; number_of_response:1; }","duration":"564.889741ms","start":"2026-10-01T20:08:40.02926Z","end":"2026-10-01T20:08:40.59415Z","steps":["trace[416426690] 'process raft request'  (duration: 354.817346ms)","trace[416426690] 'compare'  (duration: 209.46774ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:40.594228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.029232Z","time spent":"564.967723ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26759 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-01T20:08:40.594544Z","caller":"traceutil/trace.go:171","msg":"trace[1101095385] transaction","detail":"{read_only:false; response_revision:26775; number_of_response:1; }","duration":"565.231259ms","start":"2026-10-01T20:08:40.029282Z","end":"2026-10-01T20:08:40.594514Z","steps":["trace[1101095385] 'process raft request'  (duration: 564.789339ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:40.594651Z","caller":"traceutil/trace.go:171","msg":"trace[1663785858] transaction","detail":"{read_only:false; response_revision:26776; number_of_response:1; }","duration":"565.098775ms","start":"2026-10-01T20:08:40.029529Z","end":"2026-10-01T20:08:40.594627Z","steps":["trace[1663785858] 'process raft request'  (duration: 564.833319ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.594704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.029256Z","time spent":"565.356502ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26762 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-01T20:08:40.594729Z","caller":"traceutil/trace.go:171","msg":"trace[1725136659] transaction","detail":"{read_only:false; response_revision:26777; number_of_response:1; }","duration":"533.616291ms","start":"2026-10-01T20:08:40.061093Z","end":"2026-10-01T20:08:40.594709Z","steps":["trace[1725136659] 'process raft request'  (duration: 533.367586ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.594781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.029513Z","time spent":"565.197028ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26761 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:40.594791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.061074Z","time spent":"533.684242ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26763 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:40.908046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.09116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756694950 > lease_revoke:<id:426fa0f8e40fb4a7>","response":"size:30"}
{"level":"info","ts":"2026-10-01T20:08:40.909591Z","caller":"traceutil/trace.go:171","msg":"trace[1220985675] linearizableReadLoop","detail":"{readStateIndex:27660; appliedIndex:27654; }","duration":"463.856898ms","start":"2026-10-01T20:08:40.445612Z","end":"2026-10-01T20:08:40.909469Z","steps":["trace[1220985675] 'read index received'  (duration: 135.787441ms)","trace[1220985675] 'applied index is now lower than readState.Index'  (duration: 328.067337ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:40.909606Z","caller":"traceutil/trace.go:171","msg":"trace[1953406833] transaction","detail":"{read_only:false; response_revision:26778; number_of_response:1; }","duration":"487.772864ms","start":"2026-10-01T20:08:40.421736Z","end":"2026-10-01T20:08:40.909509Z","steps":["trace[1953406833] 'process raft request'  (duration: 486.393713ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:40.909874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.421708Z","time spent":"488.008749ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26764 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:41.276074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.401717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.276225Z","caller":"traceutil/trace.go:171","msg":"trace[510724993] 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:26778; }","duration":"830.587931ms","start":"2026-10-01T20:08:40.445597Z","end":"2026-10-01T20:08:41.276185Z","steps":["trace[510724993] 'agreement among raft nodes before linearized reading'  (duration: 463.99494ms)","trace[510724993] 'count revisions from in-memory index tree'  (duration: 366.336284ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:41.276298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.445539Z","time spent":"830.736944ms","remote":"127.0.0.1:50568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":30,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "}
{"level":"warn","ts":"2026-10-01T20:08:41.276397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.801405ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756694952 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:26765 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:08:41.276551Z","caller":"traceutil/trace.go:171","msg":"trace[1537844189] transaction","detail":"{read_only:false; response_revision:26779; number_of_response:1; }","duration":"758.069496ms","start":"2026-10-01T20:08:40.518459Z","end":"2026-10-01T20:08:41.276529Z","steps":["trace[1537844189] 'process raft request'  (duration: 390.998565ms)","trace[1537844189] 'compare'  (duration: 366.632312ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:41.276633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.518418Z","time spent":"758.183139ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26765 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:41.410246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4787221919756694954,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-10-01T20:08:41.694306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.313011ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.694481Z","caller":"traceutil/trace.go:171","msg":"trace[1781227322] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26779; }","duration":"198.502285ms","start":"2026-10-01T20:08:41.495956Z","end":"2026-10-01T20:08:41.694458Z","steps":["trace[1781227322] 'range keys from in-memory index tree'  (duration: 198.29475ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.694616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.774483ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756694953 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:26703 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:08:41.694949Z","caller":"traceutil/trace.go:171","msg":"trace[1169501417] linearizableReadLoop","detail":"{readStateIndex:27664; appliedIndex:27661; }","duration":"785.270377ms","start":"2026-10-01T20:08:40.909655Z","end":"2026-10-01T20:08:41.694926Z","steps":["trace[1169501417] 'read index received'  (duration: 573.226958ms)","trace[1169501417] 'applied index is now lower than readState.Index'  (duration: 212.041979ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:41.695011Z","caller":"traceutil/trace.go:171","msg":"trace[1192598134] transaction","detail":"{read_only:false; response_revision:26782; number_of_response:1; }","duration":"442.311296ms","start":"2026-10-01T20:08:41.252656Z","end":"2026-10-01T20:08:41.694968Z","steps":["trace[1192598134] 'process raft request'  (duration: 442.213954ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.695073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125268391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.695114Z","caller":"traceutil/trace.go:171","msg":"trace[237143968] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:26782; }","duration":"1.125350353s","start":"2026-10-01T20:08:40.569751Z","end":"2026-10-01T20:08:41.695101Z","steps":["trace[237143968] 'agreement among raft nodes before linearized reading'  (duration: 1.125268891s)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.69511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.185617ms","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-10-01T20:08:41.695157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.569729Z","time spent":"1.125418594s","remote":"127.0.0.1:45618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":30,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-10-01T20:08:41.695194Z","caller":"traceutil/trace.go:171","msg":"trace[317481182] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:26782; }","duration":"936.329681ms","start":"2026-10-01T20:08:40.758844Z","end":"2026-10-01T20:08:41.695173Z","steps":["trace[317481182] 'agreement among raft nodes before linearized reading'  (duration: 936.150137ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.695199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130955519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-10-01T20:08:41.695197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:41.252618Z","time spent":"442.47735ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26768 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:41.695234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.758823Z","time spent":"936.402862ms","remote":"127.0.0.1:33944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true "}
{"level":"warn","ts":"2026-10-01T20:08:41.695203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.077477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.69525Z","caller":"traceutil/trace.go:171","msg":"trace[1891697441] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26782; }","duration":"1.1310404s","start":"2026-10-01T20:08:40.564194Z","end":"2026-10-01T20:08:41.695234Z","steps":["trace[1891697441] 'agreement among raft nodes before linearized reading'  (duration: 1.130832585s)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:41.695247Z","caller":"traceutil/trace.go:171","msg":"trace[635357224] transaction","detail":"{read_only:false; response_revision:26780; number_of_response:1; }","duration":"812.066017ms","start":"2026-10-01T20:08:40.883149Z","end":"2026-10-01T20:08:41.695215Z","steps":["trace[635357224] 'process raft request'  (duration: 599.496546ms)","trace[635357224] 'compare'  (duration: 211.613878ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:41.69529Z","caller":"traceutil/trace.go:171","msg":"trace[437213128] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:26782; }","duration":"841.242681ms","start":"2026-10-01T20:08:40.854027Z","end":"2026-10-01T20:08:41.695269Z","steps":["trace[437213128] 'agreement among raft nodes before linearized reading'  (duration: 841.059407ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.695339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.854011Z","time spent":"841.318072ms","remote":"127.0.0.1:50160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "}
{"level":"warn","ts":"2026-10-01T20:08:41.695305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.564176Z","time spent":"1.131117252s","remote":"127.0.0.1:45664","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-10-01T20:08:41.695396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.883128Z","time spent":"812.18786ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:26703 > 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-10-01T20:08:41.695356Z","caller":"traceutil/trace.go:171","msg":"trace[703864025] transaction","detail":"{read_only:false; response_revision:26781; number_of_response:1; }","duration":"736.880922ms","start":"2026-10-01T20:08:40.958242Z","end":"2026-10-01T20:08:41.695123Z","steps":["trace[703864025] 'process raft request'  (duration: 736.557235ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.695638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.958183Z","time spent":"737.372903ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26767 > 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-10-01T20:08:41.698026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.01249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.698086Z","caller":"traceutil/trace.go:171","msg":"trace[1939253273] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:26783; }","duration":"701.116592ms","start":"2026-10-01T20:08:40.996953Z","end":"2026-10-01T20:08:41.69807Z","steps":["trace[1939253273] 'agreement among raft nodes before linearized reading'  (duration: 701.00509ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.69812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:40.996933Z","time spent":"701.177173ms","remote":"127.0.0.1:50188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":140,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true "}
{"level":"info","ts":"2026-10-01T20:08:41.698381Z","caller":"traceutil/trace.go:171","msg":"trace[1960726279] transaction","detail":"{read_only:false; response_revision:26783; number_of_response:1; }","duration":"151.220367ms","start":"2026-10-01T20:08:41.54715Z","end":"2026-10-01T20:08:41.69837Z","steps":["trace[1960726279] 'process raft request'  (duration: 150.685045ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.698571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.39618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.698627Z","caller":"traceutil/trace.go:171","msg":"trace[1990721629] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:26783; }","duration":"564.476882ms","start":"2026-10-01T20:08:41.134121Z","end":"2026-10-01T20:08:41.698597Z","steps":["trace[1990721629] 'agreement among raft nodes before linearized reading'  (duration: 564.415661ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:41.698659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:41.134098Z","time spent":"564.553084ms","remote":"127.0.0.1:50384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "}
{"level":"info","ts":"2026-10-01T20:08:41.859308Z","caller":"traceutil/trace.go:171","msg":"trace[1777359855] linearizableReadLoop","detail":"{readStateIndex:27666; appliedIndex:27665; }","duration":"124.978348ms","start":"2026-10-01T20:08:41.734286Z","end":"2026-10-01T20:08:41.859264Z","steps":["trace[1777359855] 'read index received'  (duration: 110.233468ms)","trace[1777359855] 'applied index is now lower than readState.Index'  (duration: 14.74289ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:41.85936Z","caller":"traceutil/trace.go:171","msg":"trace[1953442736] transaction","detail":"{read_only:false; response_revision:26784; number_of_response:1; }","duration":"158.621032ms","start":"2026-10-01T20:08:41.700684Z","end":"2026-10-01T20:08:41.859305Z","steps":["trace[1953442736] 'process raft request'  (duration: 143.82059ms)","trace[1953442736] 'compare'  (duration: 14.443444ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:41.85966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.328376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:41.859724Z","caller":"traceutil/trace.go:171","msg":"trace[1000108943] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:26784; }","duration":"125.50045ms","start":"2026-10-01T20:08:41.734204Z","end":"2026-10-01T20:08:41.859705Z","steps":["trace[1000108943] 'agreement among raft nodes before linearized reading'  (duration: 125.325166ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:42.087902Z","caller":"traceutil/trace.go:171","msg":"trace[1448215922] transaction","detail":"{read_only:false; response_revision:26785; number_of_response:1; }","duration":"209.723247ms","start":"2026-10-01T20:08:41.878155Z","end":"2026-10-01T20:08:42.087878Z","steps":["trace[1448215922] 'process raft request'  (duration: 209.500052ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:50.488547Z","caller":"traceutil/trace.go:171","msg":"trace[1221005571] transaction","detail":"{read_only:false; response_revision:26851; number_of_response:1; }","duration":"211.961368ms","start":"2026-10-01T20:08:50.27656Z","end":"2026-10-01T20:08:50.488522Z","steps":["trace[1221005571] 'process raft request'  (duration: 211.781074ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:50.77544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.925126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-10-01T20:08:50.775517Z","caller":"traceutil/trace.go:171","msg":"trace[459224968] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:26851; }","duration":"158.11267ms","start":"2026-10-01T20:08:50.617385Z","end":"2026-10-01T20:08:50.775497Z","steps":["trace[459224968] 'range keys from in-memory index tree'  (duration: 157.701572ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:50.775715Z","caller":"traceutil/trace.go:171","msg":"trace[783801632] linearizableReadLoop","detail":"{readStateIndex:27736; appliedIndex:27735; }","duration":"118.38262ms","start":"2026-10-01T20:08:50.657304Z","end":"2026-10-01T20:08:50.775687Z","steps":["trace[783801632] 'read index received'  (duration: 104.840997ms)","trace[783801632] 'applied index is now lower than readState.Index'  (duration: 13.540183ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:50.775867Z","caller":"traceutil/trace.go:171","msg":"trace[1803142048] transaction","detail":"{read_only:false; response_revision:26852; number_of_response:1; }","duration":"128.673142ms","start":"2026-10-01T20:08:50.647159Z","end":"2026-10-01T20:08:50.775832Z","steps":["trace[1803142048] 'process raft request'  (duration: 115.052086ms)","trace[1803142048] 'compare'  (duration: 12.101522ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:50.776158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.714535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-10-01T20:08:50.776189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.401961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-10-01T20:08:50.776029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.706428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-10-01T20:08:50.776244Z","caller":"traceutil/trace.go:171","msg":"trace[2120682952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26852; }","duration":"118.476483ms","start":"2026-10-01T20:08:50.657752Z","end":"2026-10-01T20:08:50.776228Z","steps":["trace[2120682952] 'agreement among raft nodes before linearized reading'  (duration: 118.32121ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:50.776288Z","caller":"traceutil/trace.go:171","msg":"trace[1474615772] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26852; }","duration":"118.988764ms","start":"2026-10-01T20:08:50.657261Z","end":"2026-10-01T20:08:50.776249Z","steps":["trace[1474615772] 'agreement among raft nodes before linearized reading'  (duration: 118.563404ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:50.776204Z","caller":"traceutil/trace.go:171","msg":"trace[538135052] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26852; }","duration":"104.818908ms","start":"2026-10-01T20:08:50.671375Z","end":"2026-10-01T20:08:50.776194Z","steps":["trace[538135052] 'agreement among raft nodes before linearized reading'  (duration: 104.704815ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:51.368997Z","caller":"traceutil/trace.go:171","msg":"trace[1003629573] transaction","detail":"{read_only:false; response_revision:26854; number_of_response:1; }","duration":"582.061965ms","start":"2026-10-01T20:08:50.786913Z","end":"2026-10-01T20:08:51.368975Z","steps":["trace[1003629573] 'process raft request'  (duration: 581.879721ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:51.369136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:50.786885Z","time spent":"582.181238ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26839 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-01T20:08:51.369163Z","caller":"traceutil/trace.go:171","msg":"trace[1725181201] transaction","detail":"{read_only:false; response_revision:26855; number_of_response:1; }","duration":"580.289275ms","start":"2026-10-01T20:08:50.788835Z","end":"2026-10-01T20:08:51.369124Z","steps":["trace[1725181201] 'process raft request'  (duration: 580.102821ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:51.36932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:50.788822Z","time spent":"580.414658ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26838 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-01T20:08:51.378395Z","caller":"traceutil/trace.go:171","msg":"trace[1437308929] transaction","detail":"{read_only:false; response_revision:26856; number_of_response:1; }","duration":"418.048872ms","start":"2026-10-01T20:08:50.96032Z","end":"2026-10-01T20:08:51.378369Z","steps":["trace[1437308929] 'process raft request'  (duration: 417.866518ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:51.378516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:50.960293Z","time spent":"418.177115ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26841 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-01T20:08:51.904333Z","caller":"traceutil/trace.go:171","msg":"trace[1655752136] transaction","detail":"{read_only:false; response_revision:26858; number_of_response:1; }","duration":"174.446977ms","start":"2026-10-01T20:08:51.729868Z","end":"2026-10-01T20:08:51.904315Z","steps":["trace[1655752136] 'process raft request'  (duration: 174.326144ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:52.493753Z","caller":"traceutil/trace.go:171","msg":"trace[988691243] transaction","detail":"{read_only:false; response_revision:26859; number_of_response:1; }","duration":"761.604915ms","start":"2026-10-01T20:08:51.732125Z","end":"2026-10-01T20:08:52.49373Z","steps":["trace[988691243] 'process raft request'  (duration: 761.39196ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.493899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:51.732106Z","time spent":"761.719848ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26845 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-01T20:08:52.49393Z","caller":"traceutil/trace.go:171","msg":"trace[653759089] transaction","detail":"{read_only:false; response_revision:26860; number_of_response:1; }","duration":"723.590965ms","start":"2026-10-01T20:08:51.77031Z","end":"2026-10-01T20:08:52.493901Z","steps":["trace[653759089] 'process raft request'  (duration: 723.35878ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:52.493948Z","caller":"traceutil/trace.go:171","msg":"trace[1841573510] linearizableReadLoop","detail":"{readStateIndex:27744; appliedIndex:27742; }","duration":"707.409563ms","start":"2026-10-01T20:08:51.786481Z","end":"2026-10-01T20:08:52.493891Z","steps":["trace[1841573510] 'read index received'  (duration: 118.166237ms)","trace[1841573510] 'applied index is now lower than readState.Index'  (duration: 589.240535ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:52.494072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:51.770299Z","time spent":"723.690898ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:26780 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:52.564478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.928362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:52.56461Z","caller":"traceutil/trace.go:171","msg":"trace[1387221498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26860; }","duration":"778.147867ms","start":"2026-10-01T20:08:51.786429Z","end":"2026-10-01T20:08:52.564577Z","steps":["trace[1387221498] 'agreement among raft nodes before linearized reading'  (duration: 707.618928ms)","trace[1387221498] 'range keys from in-memory index tree'  (duration: 70.293614ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:52.564669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:51.786385Z","time spent":"778.27291ms","remote":"127.0.0.1:45414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-01T20:08:52.838359Z","caller":"traceutil/trace.go:171","msg":"trace[624070220] transaction","detail":"{read_only:false; response_revision:26861; number_of_response:1; }","duration":"736.208997ms","start":"2026-10-01T20:08:52.102123Z","end":"2026-10-01T20:08:52.838332Z","steps":["trace[624070220] 'process raft request'  (duration: 736.005142ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.838538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.102106Z","time spent":"736.3483ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:26828 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-01T20:08:52.838683Z","caller":"traceutil/trace.go:171","msg":"trace[104376978] transaction","detail":"{read_only:false; response_revision:26862; number_of_response:1; }","duration":"702.115824ms","start":"2026-10-01T20:08:52.136555Z","end":"2026-10-01T20:08:52.838671Z","steps":["trace[104376978] 'process raft request'  (duration: 701.732225ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.838736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.136538Z","time spent":"702.170896ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26848 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-01T20:08:52.838741Z","caller":"traceutil/trace.go:171","msg":"trace[390780560] linearizableReadLoop","detail":"{readStateIndex:27748; appliedIndex:27744; }","duration":"344.689639ms","start":"2026-10-01T20:08:52.494028Z","end":"2026-10-01T20:08:52.838717Z","steps":["trace[390780560] 'read index received'  (duration: 344.109886ms)","trace[390780560] 'applied index is now lower than readState.Index'  (duration: 578.633µs)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:52.838842Z","caller":"traceutil/trace.go:171","msg":"trace[14062996] transaction","detail":"{read_only:false; response_revision:26864; number_of_response:1; }","duration":"694.557966ms","start":"2026-10-01T20:08:52.144262Z","end":"2026-10-01T20:08:52.83882Z","steps":["trace[14062996] 'process raft request'  (duration: 694.412352ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.838973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.409438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-10-01T20:08:52.838974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.144236Z","time spent":"694.669957ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26850 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-01T20:08:52.839014Z","caller":"traceutil/trace.go:171","msg":"trace[1532294259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26864; }","duration":"346.46477ms","start":"2026-10-01T20:08:52.492538Z","end":"2026-10-01T20:08:52.839003Z","steps":["trace[1532294259] 'agreement among raft nodes before linearized reading'  (duration: 346.291416ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.839051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.49247Z","time spent":"346.569842ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-10-01T20:08:52.839182Z","caller":"traceutil/trace.go:171","msg":"trace[998003828] transaction","detail":"{read_only:false; response_revision:26863; number_of_response:1; }","duration":"701.355968ms","start":"2026-10-01T20:08:52.137814Z","end":"2026-10-01T20:08:52.83917Z","steps":["trace[998003828] 'process raft request'  (duration: 700.760265ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.839212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.956686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-l3-agent-default-kfdv5.18da7ff876f4a7f2\" ","response":"range_response_count:1 size:1387"}
{"level":"info","ts":"2026-10-01T20:08:52.839251Z","caller":"traceutil/trace.go:171","msg":"trace[194204814] range","detail":"{range_begin:/registry/events/openstack/neutron-l3-agent-default-kfdv5.18da7ff876f4a7f2; range_end:; response_count:1; response_revision:26864; }","duration":"800.029787ms","start":"2026-10-01T20:08:52.03921Z","end":"2026-10-01T20:08:52.839239Z","steps":["trace[194204814] 'agreement among raft nodes before linearized reading'  (duration: 799.902514ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.839268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.137801Z","time spent":"701.43322ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26849 > 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-10-01T20:08:52.839278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.039189Z","time spent":"800.082449ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":1411,"request content":"key:\"/registry/events/openstack/neutron-l3-agent-default-kfdv5.18da7ff876f4a7f2\" "}
{"level":"warn","ts":"2026-10-01T20:08:52.839336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.313594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-01T20:08:52.839374Z","caller":"traceutil/trace.go:171","msg":"trace[1725746894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26864; }","duration":"900.391886ms","start":"2026-10-01T20:08:51.938974Z","end":"2026-10-01T20:08:52.839366Z","steps":["trace[1725746894] 'agreement among raft nodes before linearized reading'  (duration: 900.293193ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:52.839399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:51.938956Z","time spent":"900.436126ms","remote":"127.0.0.1:45664","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-10-01T20:08:53.163765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.680131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756695134 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26852 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:08:53.164057Z","caller":"traceutil/trace.go:171","msg":"trace[86269437] transaction","detail":"{read_only:false; response_revision:26868; number_of_response:1; }","duration":"320.062339ms","start":"2026-10-01T20:08:52.843976Z","end":"2026-10-01T20:08:53.164038Z","steps":["trace[86269437] 'process raft request'  (duration: 320.022998ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.164131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.843923Z","time spent":"320.175771ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26851 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-01T20:08:53.164285Z","caller":"traceutil/trace.go:171","msg":"trace[2140130093] transaction","detail":"{read_only:false; response_revision:26865; number_of_response:1; }","duration":"383.290615ms","start":"2026-10-01T20:08:52.780971Z","end":"2026-10-01T20:08:53.164261Z","steps":["trace[2140130093] 'process raft request'  (duration: 271.038181ms)","trace[2140130093] 'compare'  (duration: 111.558099ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:08:53.164398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.780946Z","time spent":"383.389136ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26852 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-01T20:08:53.164431Z","caller":"traceutil/trace.go:171","msg":"trace[2118023331] linearizableReadLoop","detail":"{readStateIndex:27749; appliedIndex:27748; }","duration":"325.575531ms","start":"2026-10-01T20:08:52.838802Z","end":"2026-10-01T20:08:53.164378Z","steps":["trace[2118023331] 'read index received'  (duration: 213.220405ms)","trace[2118023331] 'applied index is now lower than readState.Index'  (duration: 112.351676ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:08:53.164461Z","caller":"traceutil/trace.go:171","msg":"trace[1972049514] transaction","detail":"{read_only:false; response_revision:26867; number_of_response:1; }","duration":"321.125102ms","start":"2026-10-01T20:08:52.843302Z","end":"2026-10-01T20:08:53.164428Z","steps":["trace[1972049514] 'process raft request'  (duration: 320.658382ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.164501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.389158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:53.164552Z","caller":"traceutil/trace.go:171","msg":"trace[17510423] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:26868; }","duration":"530.45773ms","start":"2026-10-01T20:08:52.634079Z","end":"2026-10-01T20:08:53.164536Z","steps":["trace[17510423] 'agreement among raft nodes before linearized reading'  (duration: 530.344957ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.164556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.894718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-10-01T20:08:53.164555Z","caller":"traceutil/trace.go:171","msg":"trace[1389996705] transaction","detail":"{read_only:false; response_revision:26866; number_of_response:1; }","duration":"323.039585ms","start":"2026-10-01T20:08:52.841489Z","end":"2026-10-01T20:08:53.164529Z","steps":["trace[1389996705] 'process raft request'  (duration: 322.37541ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.164587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.713979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:08:53.164603Z","caller":"traceutil/trace.go:171","msg":"trace[82191194] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26868; }","duration":"550.964299ms","start":"2026-10-01T20:08:52.613626Z","end":"2026-10-01T20:08:53.16459Z","steps":["trace[82191194] 'agreement among raft nodes before linearized reading'  (duration: 550.822036ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:53.164614Z","caller":"traceutil/trace.go:171","msg":"trace[2129704553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26868; }","duration":"598.78161ms","start":"2026-10-01T20:08:52.565826Z","end":"2026-10-01T20:08:53.164607Z","steps":["trace[2129704553] 'agreement among raft nodes before linearized reading'  (duration: 598.727529ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.164597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.634035Z","time spent":"530.552102ms","remote":"127.0.0.1:50298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true "}
{"level":"warn","ts":"2026-10-01T20:08:53.164612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.843286Z","time spent":"321.255675ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26846 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:53.164631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.565807Z","time spent":"598.821471ms","remote":"127.0.0.1:45430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-01T20:08:53.164631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.613615Z","time spent":"551.010711ms","remote":"127.0.0.1:45586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-01T20:08:53.164721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.841465Z","time spent":"323.151407ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1369,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/events/openstack/neutron-l3-agent-default-kfdv5.18da7ff876f4a7f2\" mod_revision:26129 > success:<request_put:<key:\"/registry/events/openstack/neutron-l3-agent-default-kfdv5.18da7ff876f4a7f2\" value_size:1277 lease:4787221919756694860 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-l3-agent-default-kfdv5.18da7ff876f4a7f2\" > >"}
{"level":"warn","ts":"2026-10-01T20:08:53.164739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.829378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-10-01T20:08:53.164791Z","caller":"traceutil/trace.go:171","msg":"trace[1161063414] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:26868; }","duration":"225.936981ms","start":"2026-10-01T20:08:52.938837Z","end":"2026-10-01T20:08:53.164774Z","steps":["trace[1161063414] 'agreement among raft nodes before linearized reading'  (duration: 225.753647ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.16476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.692054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-10-01T20:08:53.164815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.592635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129689"}
{"level":"info","ts":"2026-10-01T20:08:53.164861Z","caller":"traceutil/trace.go:171","msg":"trace[1861407730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26868; }","duration":"337.877407ms","start":"2026-10-01T20:08:52.826959Z","end":"2026-10-01T20:08:53.164836Z","steps":["trace[1861407730] 'agreement among raft nodes before linearized reading'  (duration: 337.51959ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:08:53.164898Z","caller":"traceutil/trace.go:171","msg":"trace[1846589731] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:26868; }","duration":"172.713658ms","start":"2026-10-01T20:08:52.992162Z","end":"2026-10-01T20:08:53.164875Z","steps":["trace[1846589731] 'agreement among raft nodes before linearized reading'  (duration: 172.432762ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:08:53.164921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:08:52.826927Z","time spent":"337.97917ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-01T20:09:02.349581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.148107ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756695474 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" mod_revision:26968 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" value_size:3646 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:02.349794Z","caller":"traceutil/trace.go:171","msg":"trace[1039203637] transaction","detail":"{read_only:false; response_revision:26992; number_of_response:1; }","duration":"412.678392ms","start":"2026-10-01T20:09:01.937098Z","end":"2026-10-01T20:09:02.349777Z","steps":["trace[1039203637] 'process raft request'  (duration: 412.58354ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:02.349867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:01.937074Z","time spent":"412.758465ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26919 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-01T20:09:02.350004Z","caller":"traceutil/trace.go:171","msg":"trace[1571604734] linearizableReadLoop","detail":"{readStateIndex:27877; appliedIndex:27876; }","duration":"445.64319ms","start":"2026-10-01T20:09:01.904342Z","end":"2026-10-01T20:09:02.349985Z","steps":["trace[1571604734] 'read index received'  (duration: 213.983422ms)","trace[1571604734] 'applied index is now lower than readState.Index'  (duration: 231.658608ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:02.350195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.831564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" ","response":"range_response_count:1 size:3764"}
{"level":"info","ts":"2026-10-01T20:09:02.350238Z","caller":"traceutil/trace.go:171","msg":"trace[346701133] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec; range_end:; response_count:1; response_revision:26992; }","duration":"445.915156ms","start":"2026-10-01T20:09:01.904311Z","end":"2026-10-01T20:09:02.350226Z","steps":["trace[346701133] 'agreement among raft nodes before linearized reading'  (duration: 445.791103ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:02.350272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:01.904301Z","time spent":"445.963207ms","remote":"127.0.0.1:45586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3788,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" "}
{"level":"warn","ts":"2026-10-01T20:09:02.350348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.141817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-01T20:09:02.350424Z","caller":"traceutil/trace.go:171","msg":"trace[1648050498] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:26992; }","duration":"214.258828ms","start":"2026-10-01T20:09:02.136153Z","end":"2026-10-01T20:09:02.350411Z","steps":["trace[1648050498] 'agreement among raft nodes before linearized reading'  (duration: 214.087445ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:02.35056Z","caller":"traceutil/trace.go:171","msg":"trace[1707523346] transaction","detail":"{read_only:false; response_revision:26991; number_of_response:1; }","duration":"453.397375ms","start":"2026-10-01T20:09:01.896532Z","end":"2026-10-01T20:09:02.34993Z","steps":["trace[1707523346] 'process raft request'  (duration: 221.806978ms)","trace[1707523346] 'compare'  (duration: 230.597624ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:02.350662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:01.896508Z","time spent":"454.09345ms","remote":"127.0.0.1:45586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3746,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" mod_revision:26968 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" value_size:3646 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a276be4-532a-4dbf-bb33-b98e67eb48ec\" > >"}
{"level":"warn","ts":"2026-10-01T20:09:02.800321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.628887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:02.800421Z","caller":"traceutil/trace.go:171","msg":"trace[1938747780] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:26992; }","duration":"327.76684ms","start":"2026-10-01T20:09:02.472613Z","end":"2026-10-01T20:09:02.80038Z","steps":["trace[1938747780] 'count revisions from in-memory index tree'  (duration: 327.470044ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:02.800459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:02.472591Z","time spent":"327.858902ms","remote":"127.0.0.1:56750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "}
{"level":"warn","ts":"2026-10-01T20:09:02.800635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.615348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-01T20:09:02.800657Z","caller":"traceutil/trace.go:171","msg":"trace[761983125] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:26992; }","duration":"323.67731ms","start":"2026-10-01T20:09:02.476973Z","end":"2026-10-01T20:09:02.80065Z","steps":["trace[761983125] 'count revisions from in-memory index tree'  (duration: 323.451814ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:02.800674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:02.476952Z","time spent":"323.7141ms","remote":"127.0.0.1:33958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":4,"response size":32,"request content":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true "}
{"level":"info","ts":"2026-10-01T20:09:02.80091Z","caller":"traceutil/trace.go:171","msg":"trace[1746229623] transaction","detail":"{read_only:false; response_revision:26993; number_of_response:1; }","duration":"267.300636ms","start":"2026-10-01T20:09:02.533595Z","end":"2026-10-01T20:09:02.800896Z","steps":["trace[1746229623] 'process raft request'  (duration: 188.448471ms)","trace[1746229623] 'compare'  (duration: 78.741873ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:02.857576Z","caller":"traceutil/trace.go:171","msg":"trace[565351559] transaction","detail":"{read_only:false; response_revision:26994; number_of_response:1; }","duration":"249.756264ms","start":"2026-10-01T20:09:02.607787Z","end":"2026-10-01T20:09:02.857543Z","steps":["trace[565351559] 'process raft request'  (duration: 249.505858ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.010585Z","caller":"traceutil/trace.go:171","msg":"trace[141838409] linearizableReadLoop","detail":"{readStateIndex:27881; appliedIndex:27880; }","duration":"153.076639ms","start":"2026-10-01T20:09:02.85748Z","end":"2026-10-01T20:09:03.010557Z","steps":["trace[141838409] 'read index received'  (duration: 95.418107ms)","trace[141838409] 'applied index is now lower than readState.Index'  (duration: 57.656832ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:03.010735Z","caller":"traceutil/trace.go:171","msg":"trace[113637774] transaction","detail":"{read_only:false; response_revision:26995; number_of_response:1; }","duration":"155.100894ms","start":"2026-10-01T20:09:02.855587Z","end":"2026-10-01T20:09:03.010688Z","steps":["trace[113637774] 'process raft request'  (duration: 97.310899ms)","trace[113637774] 'compare'  (duration: 57.291613ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:03.01087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.471252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19027"}
{"level":"info","ts":"2026-10-01T20:09:03.01093Z","caller":"traceutil/trace.go:171","msg":"trace[711511284] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26995; }","duration":"193.549475ms","start":"2026-10-01T20:09:02.817366Z","end":"2026-10-01T20:09:03.010915Z","steps":["trace[711511284] 'agreement among raft nodes before linearized reading'  (duration: 193.33975ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:03.012359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.414466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:03.012443Z","caller":"traceutil/trace.go:171","msg":"trace[1613367445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26998; }","duration":"153.563449ms","start":"2026-10-01T20:09:02.858866Z","end":"2026-10-01T20:09:03.012429Z","steps":["trace[1613367445] 'agreement among raft nodes before linearized reading'  (duration: 153.424946ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.012654Z","caller":"traceutil/trace.go:171","msg":"trace[400365653] transaction","detail":"{read_only:false; response_revision:26997; number_of_response:1; }","duration":"133.239773ms","start":"2026-10-01T20:09:02.879367Z","end":"2026-10-01T20:09:03.012607Z","steps":["trace[400365653] 'process raft request'  (duration: 132.845365ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:03.012715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.182064ms","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-10-01T20:09:03.012746Z","caller":"traceutil/trace.go:171","msg":"trace[1663046483] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26998; }","duration":"146.260005ms","start":"2026-10-01T20:09:02.866477Z","end":"2026-10-01T20:09:03.012737Z","steps":["trace[1663046483] 'agreement among raft nodes before linearized reading'  (duration: 146.167263ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.012819Z","caller":"traceutil/trace.go:171","msg":"trace[1751682979] transaction","detail":"{read_only:false; response_revision:26996; number_of_response:1; }","duration":"133.638463ms","start":"2026-10-01T20:09:02.879168Z","end":"2026-10-01T20:09:03.012806Z","steps":["trace[1751682979] 'process raft request'  (duration: 132.944007ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.012864Z","caller":"traceutil/trace.go:171","msg":"trace[917159729] transaction","detail":"{read_only:false; response_revision:26998; number_of_response:1; }","duration":"133.375987ms","start":"2026-10-01T20:09:02.879481Z","end":"2026-10-01T20:09:03.012857Z","steps":["trace[917159729] 'process raft request'  (duration: 132.771104ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.372506Z","caller":"traceutil/trace.go:171","msg":"trace[846465466] linearizableReadLoop","detail":"{readStateIndex:27885; appliedIndex:27884; }","duration":"341.267333ms","start":"2026-10-01T20:09:03.031216Z","end":"2026-10-01T20:09:03.372483Z","steps":["trace[846465466] 'read index received'  (duration: 274.332564ms)","trace[846465466] 'applied index is now lower than readState.Index'  (duration: 66.934009ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:03.372807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.785532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:03.372892Z","caller":"traceutil/trace.go:171","msg":"trace[6784374] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:27000; }","duration":"298.948535ms","start":"2026-10-01T20:09:03.073924Z","end":"2026-10-01T20:09:03.372873Z","steps":["trace[6784374] 'agreement among raft nodes before linearized reading'  (duration: 298.776091ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:03.372914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.222294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-01T20:09:03.372946Z","caller":"traceutil/trace.go:171","msg":"trace[1942940205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27000; }","duration":"154.304316ms","start":"2026-10-01T20:09:03.218631Z","end":"2026-10-01T20:09:03.372936Z","steps":["trace[1942940205] 'agreement among raft nodes before linearized reading'  (duration: 154.176514ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:03.372973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.095694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-10-01T20:09:03.373043Z","caller":"traceutil/trace.go:171","msg":"trace[2128744489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27000; }","duration":"159.210176ms","start":"2026-10-01T20:09:03.213816Z","end":"2026-10-01T20:09:03.373027Z","steps":["trace[2128744489] 'agreement among raft nodes before linearized reading'  (duration: 159.027732ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:03.373197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.076002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:03.373246Z","caller":"traceutil/trace.go:171","msg":"trace[401584530] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:27000; }","duration":"284.168244ms","start":"2026-10-01T20:09:03.089063Z","end":"2026-10-01T20:09:03.373231Z","steps":["trace[401584530] 'agreement among raft nodes before linearized reading'  (duration: 284.088762ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.373231Z","caller":"traceutil/trace.go:171","msg":"trace[1096606008] transaction","detail":"{read_only:false; response_revision:27000; number_of_response:1; }","duration":"168.203607ms","start":"2026-10-01T20:09:03.20499Z","end":"2026-10-01T20:09:03.373194Z","steps":["trace[1096606008] 'process raft request'  (duration: 167.44699ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:03.373347Z","caller":"traceutil/trace.go:171","msg":"trace[2011540049] transaction","detail":"{read_only:false; response_revision:26999; number_of_response:1; }","duration":"344.112847ms","start":"2026-10-01T20:09:03.028366Z","end":"2026-10-01T20:09:03.372479Z","steps":["trace[2011540049] 'process raft request'  (duration: 277.2531ms)","trace[2011540049] 'compare'  (duration: 66.678923ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:03.373551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:03.028347Z","time spent":"345.107479ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":724,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18da80baa5f2c1d9\" mod_revision:26974 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18da80baa5f2c1d9\" value_size:647 lease:4787221919756694860 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18da80baa5f2c1d9\" > >"}
{"level":"warn","ts":"2026-10-01T20:09:03.372888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.662462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"}
{"level":"info","ts":"2026-10-01T20:09:03.374032Z","caller":"traceutil/trace.go:171","msg":"trace[647355494] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:27000; }","duration":"342.827367ms","start":"2026-10-01T20:09:03.03119Z","end":"2026-10-01T20:09:03.374017Z","steps":["trace[647355494] 'agreement among raft nodes before linearized reading'  (duration: 341.403486ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:03.374078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:09:03.031177Z","time spent":"342.884889ms","remote":"127.0.0.1:45894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9628,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "}
{"level":"warn","ts":"2026-10-01T20:09:33.880286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.118041ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696127 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:27254 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:33.880431Z","caller":"traceutil/trace.go:171","msg":"trace[1058751643] transaction","detail":"{read_only:false; response_revision:27267; number_of_response:1; }","duration":"194.792202ms","start":"2026-10-01T20:09:33.685614Z","end":"2026-10-01T20:09:33.880406Z","steps":["trace[1058751643] 'process raft request'  (duration: 57.450666ms)","trace[1058751643] 'compare'  (duration: 136.801515ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:33.89145Z","caller":"traceutil/trace.go:171","msg":"trace[1476764904] transaction","detail":"{read_only:false; response_revision:27269; number_of_response:1; }","duration":"205.591624ms","start":"2026-10-01T20:09:33.685832Z","end":"2026-10-01T20:09:33.891424Z","steps":["trace[1476764904] 'process raft request'  (duration: 205.491702ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:33.89158Z","caller":"traceutil/trace.go:171","msg":"trace[422879075] transaction","detail":"{read_only:false; response_revision:27268; number_of_response:1; }","duration":"205.709497ms","start":"2026-10-01T20:09:33.685786Z","end":"2026-10-01T20:09:33.891495Z","steps":["trace[422879075] 'process raft request'  (duration: 205.422611ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:33.891814Z","caller":"traceutil/trace.go:171","msg":"trace[1621500222] transaction","detail":"{read_only:false; response_revision:27270; number_of_response:1; }","duration":"205.071312ms","start":"2026-10-01T20:09:33.68671Z","end":"2026-10-01T20:09:33.891781Z","steps":["trace[1621500222] 'process raft request'  (duration: 204.672553ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:33.892303Z","caller":"traceutil/trace.go:171","msg":"trace[1097494879] linearizableReadLoop","detail":"{readStateIndex:28162; appliedIndex:28158; }","duration":"204.96047ms","start":"2026-10-01T20:09:33.687284Z","end":"2026-10-01T20:09:33.892245Z","steps":["trace[1097494879] 'read index received'  (duration: 55.78402ms)","trace[1097494879] 'applied index is now lower than readState.Index'  (duration: 149.17238ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:33.89237Z","caller":"traceutil/trace.go:171","msg":"trace[1863627563] transaction","detail":"{read_only:false; response_revision:27271; number_of_response:1; }","duration":"203.608349ms","start":"2026-10-01T20:09:33.688718Z","end":"2026-10-01T20:09:33.892326Z","steps":["trace[1863627563] 'process raft request'  (duration: 202.962485ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:33.892525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.234016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"}
{"level":"info","ts":"2026-10-01T20:09:33.892591Z","caller":"traceutil/trace.go:171","msg":"trace[459960668] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:27271; }","duration":"205.306168ms","start":"2026-10-01T20:09:33.687271Z","end":"2026-10-01T20:09:33.892577Z","steps":["trace[459960668] 'agreement among raft nodes before linearized reading'  (duration: 205.159405ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:33.89259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.364254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:33.892861Z","caller":"traceutil/trace.go:171","msg":"trace[957303820] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:27271; }","duration":"165.666761ms","start":"2026-10-01T20:09:33.727179Z","end":"2026-10-01T20:09:33.892845Z","steps":["trace[957303820] 'agreement among raft nodes before linearized reading'  (duration: 165.346403ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:33.893008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.12371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:33.893056Z","caller":"traceutil/trace.go:171","msg":"trace[1656681064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27271; }","duration":"107.224212ms","start":"2026-10-01T20:09:33.785819Z","end":"2026-10-01T20:09:33.893043Z","steps":["trace[1656681064] 'agreement among raft nodes before linearized reading'  (duration: 107.13465ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:34.481986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.041188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-10-01T20:09:34.482067Z","caller":"traceutil/trace.go:171","msg":"trace[225580343] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27272; }","duration":"141.194221ms","start":"2026-10-01T20:09:34.340852Z","end":"2026-10-01T20:09:34.482047Z","steps":["trace[225580343] 'range keys from in-memory index tree'  (duration: 140.780092ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:35.19325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.409347ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696159 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:27258 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:35.193468Z","caller":"traceutil/trace.go:171","msg":"trace[1274971213] transaction","detail":"{read_only:false; response_revision:27275; number_of_response:1; }","duration":"217.325008ms","start":"2026-10-01T20:09:34.976129Z","end":"2026-10-01T20:09:35.193454Z","steps":["trace[1274971213] 'process raft request'  (duration: 217.226946ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:35.193511Z","caller":"traceutil/trace.go:171","msg":"trace[1627856145] transaction","detail":"{read_only:false; response_revision:27274; number_of_response:1; }","duration":"243.535013ms","start":"2026-10-01T20:09:34.949948Z","end":"2026-10-01T20:09:35.193483Z","steps":["trace[1627856145] 'process raft request'  (duration: 130.813349ms)","trace[1627856145] 'compare'  (duration: 112.225244ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:41.449543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.541201ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696259 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:27303 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:41.449725Z","caller":"traceutil/trace.go:171","msg":"trace[268731941] transaction","detail":"{read_only:false; response_revision:27317; number_of_response:1; }","duration":"229.230214ms","start":"2026-10-01T20:09:41.220474Z","end":"2026-10-01T20:09:41.449704Z","steps":["trace[268731941] 'process raft request'  (duration: 112.431799ms)","trace[268731941] 'compare'  (duration: 116.203962ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:41.450016Z","caller":"traceutil/trace.go:171","msg":"trace[73907539] transaction","detail":"{read_only:false; response_revision:27318; number_of_response:1; }","duration":"225.295475ms","start":"2026-10-01T20:09:41.224699Z","end":"2026-10-01T20:09:41.449994Z","steps":["trace[73907539] 'process raft request'  (duration: 224.943747ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:41.45006Z","caller":"traceutil/trace.go:171","msg":"trace[946700406] transaction","detail":"{read_only:false; response_revision:27319; number_of_response:1; }","duration":"225.244414ms","start":"2026-10-01T20:09:41.224802Z","end":"2026-10-01T20:09:41.450047Z","steps":["trace[946700406] 'process raft request'  (duration: 225.093371ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:41.879142Z","caller":"traceutil/trace.go:171","msg":"trace[1009465336] linearizableReadLoop","detail":"{readStateIndex:28216; appliedIndex:28215; }","duration":"110.031534ms","start":"2026-10-01T20:09:41.769078Z","end":"2026-10-01T20:09:41.87911Z","steps":["trace[1009465336] 'read index received'  (duration: 84.347739ms)","trace[1009465336] 'applied index is now lower than readState.Index'  (duration: 25.682415ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:41.879458Z","caller":"traceutil/trace.go:171","msg":"trace[2111470298] transaction","detail":"{read_only:false; response_revision:27322; number_of_response:1; }","duration":"172.204957ms","start":"2026-10-01T20:09:41.707238Z","end":"2026-10-01T20:09:41.879443Z","steps":["trace[2111470298] 'process raft request'  (duration: 146.182664ms)","trace[2111470298] 'compare'  (duration: 25.570542ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:41.879727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.628928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-01T20:09:41.879782Z","caller":"traceutil/trace.go:171","msg":"trace[901966550] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:27322; }","duration":"110.751591ms","start":"2026-10-01T20:09:41.769016Z","end":"2026-10-01T20:09:41.879768Z","steps":["trace[901966550] 'agreement among raft nodes before linearized reading'  (duration: 110.647958ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:41.888045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.901843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:41.888216Z","caller":"traceutil/trace.go:171","msg":"trace[1599282315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27323; }","duration":"102.098727ms","start":"2026-10-01T20:09:41.786092Z","end":"2026-10-01T20:09:41.888191Z","steps":["trace[1599282315] 'agreement among raft nodes before linearized reading'  (duration: 101.881662ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:42.149901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.345849ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696279 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:27313 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:42.150017Z","caller":"traceutil/trace.go:171","msg":"trace[331283839] transaction","detail":"{read_only:false; response_revision:27325; number_of_response:1; }","duration":"187.146602ms","start":"2026-10-01T20:09:41.962848Z","end":"2026-10-01T20:09:42.149995Z","steps":["trace[331283839] 'process raft request'  (duration: 69.383154ms)","trace[331283839] 'compare'  (duration: 116.758876ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:42.180671Z","caller":"traceutil/trace.go:171","msg":"trace[1026844732] transaction","detail":"{read_only:false; response_revision:27326; number_of_response:1; }","duration":"217.655165ms","start":"2026-10-01T20:09:41.962977Z","end":"2026-10-01T20:09:42.180632Z","steps":["trace[1026844732] 'process raft request'  (duration: 217.41083ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:42.180761Z","caller":"traceutil/trace.go:171","msg":"trace[1496576159] transaction","detail":"{read_only:false; response_revision:27328; number_of_response:1; }","duration":"217.647814ms","start":"2026-10-01T20:09:41.963089Z","end":"2026-10-01T20:09:42.180737Z","steps":["trace[1496576159] 'process raft request'  (duration: 217.46161ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:42.180647Z","caller":"traceutil/trace.go:171","msg":"trace[1083556797] transaction","detail":"{read_only:false; response_revision:27327; number_of_response:1; }","duration":"217.536452ms","start":"2026-10-01T20:09:41.963051Z","end":"2026-10-01T20:09:42.180588Z","steps":["trace[1083556797] 'process raft request'  (duration: 217.45792ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:43.376082Z","caller":"traceutil/trace.go:171","msg":"trace[282407554] transaction","detail":"{read_only:false; response_revision:27332; number_of_response:1; }","duration":"142.955681ms","start":"2026-10-01T20:09:43.233097Z","end":"2026-10-01T20:09:43.376053Z","steps":["trace[282407554] 'process raft request'  (duration: 134.989513ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:43.619518Z","caller":"traceutil/trace.go:171","msg":"trace[266572764] transaction","detail":"{read_only:false; response_revision:27336; number_of_response:1; }","duration":"163.539293ms","start":"2026-10-01T20:09:43.455952Z","end":"2026-10-01T20:09:43.619492Z","steps":["trace[266572764] 'process raft request'  (duration: 163.501332ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:43.619586Z","caller":"traceutil/trace.go:171","msg":"trace[880384135] transaction","detail":"{read_only:false; response_revision:27334; number_of_response:1; }","duration":"164.183018ms","start":"2026-10-01T20:09:43.455374Z","end":"2026-10-01T20:09:43.619557Z","steps":["trace[880384135] 'process raft request'  (duration: 163.931192ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:43.619587Z","caller":"traceutil/trace.go:171","msg":"trace[1336290553] transaction","detail":"{read_only:false; response_revision:27333; number_of_response:1; }","duration":"268.34397ms","start":"2026-10-01T20:09:43.351198Z","end":"2026-10-01T20:09:43.619542Z","steps":["trace[1336290553] 'process raft request'  (duration: 171.262756ms)","trace[1336290553] 'compare'  (duration: 96.533782ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:43.619758Z","caller":"traceutil/trace.go:171","msg":"trace[952218236] transaction","detail":"{read_only:false; response_revision:27335; number_of_response:1; }","duration":"164.149727ms","start":"2026-10-01T20:09:43.455597Z","end":"2026-10-01T20:09:43.619747Z","steps":["trace[952218236] 'process raft request'  (duration: 163.81215ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:43.823585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.520886ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696294 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:27320 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:43.82369Z","caller":"traceutil/trace.go:171","msg":"trace[750001061] transaction","detail":"{read_only:false; response_revision:27337; number_of_response:1; }","duration":"140.238441ms","start":"2026-10-01T20:09:43.68343Z","end":"2026-10-01T20:09:43.823668Z","steps":["trace[750001061] 'process raft request'  (duration: 37.552561ms)","trace[750001061] 'compare'  (duration: 102.412713ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:43.860483Z","caller":"traceutil/trace.go:171","msg":"trace[953610555] transaction","detail":"{read_only:false; response_revision:27338; number_of_response:1; }","duration":"124.237953ms","start":"2026-10-01T20:09:43.736212Z","end":"2026-10-01T20:09:43.86045Z","steps":["trace[953610555] 'process raft request'  (duration: 124.010708ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:44.08861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.91072ms","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-10-01T20:09:44.088694Z","caller":"traceutil/trace.go:171","msg":"trace[1385153299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27339; }","duration":"126.043383ms","start":"2026-10-01T20:09:43.962632Z","end":"2026-10-01T20:09:44.088676Z","steps":["trace[1385153299] 'range keys from in-memory index tree'  (duration: 125.746816ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:44.309672Z","caller":"traceutil/trace.go:171","msg":"trace[842342697] linearizableReadLoop","detail":"{readStateIndex:28235; appliedIndex:28234; }","duration":"124.265043ms","start":"2026-10-01T20:09:44.18538Z","end":"2026-10-01T20:09:44.309645Z","steps":["trace[842342697] 'read index received'  (duration: 51.253938ms)","trace[842342697] 'applied index is now lower than readState.Index'  (duration: 73.009935ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:44.309809Z","caller":"traceutil/trace.go:171","msg":"trace[1157612833] transaction","detail":"{read_only:false; response_revision:27341; number_of_response:1; }","duration":"146.601303ms","start":"2026-10-01T20:09:44.16314Z","end":"2026-10-01T20:09:44.309742Z","steps":["trace[1157612833] 'process raft request'  (duration: 73.480516ms)","trace[1157612833] 'compare'  (duration: 72.912802ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:44.309925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.046418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-10-01T20:09:44.309969Z","caller":"traceutil/trace.go:171","msg":"trace[797749285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27341; }","duration":"124.12464ms","start":"2026-10-01T20:09:44.185828Z","end":"2026-10-01T20:09:44.309953Z","steps":["trace[797749285] 'agreement among raft nodes before linearized reading'  (duration: 123.971966ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:44.310088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.447731ms","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":"warn","ts":"2026-10-01T20:09:44.310133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.736803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-01T20:09:44.310199Z","caller":"traceutil/trace.go:171","msg":"trace[1500559849] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:27341; }","duration":"105.606995ms","start":"2026-10-01T20:09:44.204567Z","end":"2026-10-01T20:09:44.310174Z","steps":["trace[1500559849] 'agreement among raft nodes before linearized reading'  (duration: 105.351049ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:44.310204Z","caller":"traceutil/trace.go:171","msg":"trace[452383383] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27341; }","duration":"124.871176ms","start":"2026-10-01T20:09:44.185313Z","end":"2026-10-01T20:09:44.310184Z","steps":["trace[452383383] 'agreement among raft nodes before linearized reading'  (duration: 124.423196ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:44.310186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.609228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-10-01T20:09:44.310304Z","caller":"traceutil/trace.go:171","msg":"trace[1353558522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27341; }","duration":"123.771172ms","start":"2026-10-01T20:09:44.186511Z","end":"2026-10-01T20:09:44.310282Z","steps":["trace[1353558522] 'agreement among raft nodes before linearized reading'  (duration: 123.431405ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:44.568189Z","caller":"traceutil/trace.go:171","msg":"trace[481250080] linearizableReadLoop","detail":"{readStateIndex:28238; appliedIndex:28235; }","duration":"236.187329ms","start":"2026-10-01T20:09:44.331974Z","end":"2026-10-01T20:09:44.568162Z","steps":["trace[481250080] 'read index received'  (duration: 51.697428ms)","trace[481250080] 'applied index is now lower than readState.Index'  (duration: 184.488781ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:44.568276Z","caller":"traceutil/trace.go:171","msg":"trace[85879192] transaction","detail":"{read_only:false; response_revision:27344; number_of_response:1; }","duration":"252.877443ms","start":"2026-10-01T20:09:44.315365Z","end":"2026-10-01T20:09:44.568242Z","steps":["trace[85879192] 'process raft request'  (duration: 252.631558ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:44.568321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.327762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-01T20:09:44.568378Z","caller":"traceutil/trace.go:171","msg":"trace[171349982] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:27344; }","duration":"236.465695ms","start":"2026-10-01T20:09:44.3319Z","end":"2026-10-01T20:09:44.568366Z","steps":["trace[171349982] 'agreement among raft nodes before linearized reading'  (duration: 236.356262ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:44.810056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.73176ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696313 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:27329 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:44.810174Z","caller":"traceutil/trace.go:171","msg":"trace[423301342] linearizableReadLoop","detail":"{readStateIndex:28240; appliedIndex:28239; }","duration":"176.395821ms","start":"2026-10-01T20:09:44.633756Z","end":"2026-10-01T20:09:44.810152Z","steps":["trace[423301342] 'read index received'  (duration: 40.314162ms)","trace[423301342] 'applied index is now lower than readState.Index'  (duration: 136.080249ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:44.810238Z","caller":"traceutil/trace.go:171","msg":"trace[319467490] transaction","detail":"{read_only:false; response_revision:27346; number_of_response:1; }","duration":"178.300564ms","start":"2026-10-01T20:09:44.631906Z","end":"2026-10-01T20:09:44.810206Z","steps":["trace[319467490] 'process raft request'  (duration: 42.320248ms)","trace[319467490] 'compare'  (duration: 135.569307ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:44.810456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.666996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-10-01T20:09:44.810539Z","caller":"traceutil/trace.go:171","msg":"trace[353961276] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27346; }","duration":"176.7898ms","start":"2026-10-01T20:09:44.63373Z","end":"2026-10-01T20:09:44.81052Z","steps":["trace[353961276] 'agreement among raft nodes before linearized reading'  (duration: 176.498133ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:45.093784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.647735ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696320 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.211\" mod_revision:27275 > success:<request_put:<key:\"/registry/masterleases/162.253.55.211\" value_size:68 lease:4787221919756696317 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.211\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:45.093894Z","caller":"traceutil/trace.go:171","msg":"trace[561983035] linearizableReadLoop","detail":"{readStateIndex:28242; appliedIndex:28241; }","duration":"204.06698ms","start":"2026-10-01T20:09:44.889808Z","end":"2026-10-01T20:09:45.093875Z","steps":["trace[561983035] 'read index received'  (duration: 36.192581ms)","trace[561983035] 'applied index is now lower than readState.Index'  (duration: 167.873339ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:45.093982Z","caller":"traceutil/trace.go:171","msg":"trace[1416019557] transaction","detail":"{read_only:false; response_revision:27347; number_of_response:1; }","duration":"206.997366ms","start":"2026-10-01T20:09:44.886973Z","end":"2026-10-01T20:09:45.09397Z","steps":["trace[1416019557] 'process raft request'  (duration: 39.055885ms)","trace[1416019557] 'compare'  (duration: 167.522082ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:09:45.094356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.476239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:45.094481Z","caller":"traceutil/trace.go:171","msg":"trace[927018188] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27347; }","duration":"204.652673ms","start":"2026-10-01T20:09:44.889803Z","end":"2026-10-01T20:09:45.094455Z","steps":["trace[927018188] 'agreement among raft nodes before linearized reading'  (duration: 204.383737ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:45.899122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.222852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696332 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:27334 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:09:45.899273Z","caller":"traceutil/trace.go:171","msg":"trace[1369399993] transaction","detail":"{read_only:false; response_revision:27350; number_of_response:1; }","duration":"273.219129ms","start":"2026-10-01T20:09:45.626036Z","end":"2026-10-01T20:09:45.899255Z","steps":["trace[1369399993] 'process raft request'  (duration: 148.787692ms)","trace[1369399993] 'compare'  (duration: 123.745451ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:45.899471Z","caller":"traceutil/trace.go:171","msg":"trace[476321598] linearizableReadLoop","detail":"{readStateIndex:28246; appliedIndex:28243; }","duration":"223.417664ms","start":"2026-10-01T20:09:45.676044Z","end":"2026-10-01T20:09:45.899461Z","steps":["trace[476321598] 'read index received'  (duration: 42.199145ms)","trace[476321598] 'applied index is now lower than readState.Index'  (duration: 181.217489ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:09:45.899661Z","caller":"traceutil/trace.go:171","msg":"trace[2020810430] transaction","detail":"{read_only:false; response_revision:27351; number_of_response:1; }","duration":"273.600718ms","start":"2026-10-01T20:09:45.626042Z","end":"2026-10-01T20:09:45.899642Z","steps":["trace[2020810430] 'process raft request'  (duration: 273.164628ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:45.899921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.863434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1987"}
{"level":"info","ts":"2026-10-01T20:09:45.899984Z","caller":"traceutil/trace.go:171","msg":"trace[2076501790] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:27352; }","duration":"223.967376ms","start":"2026-10-01T20:09:45.676008Z","end":"2026-10-01T20:09:45.899975Z","steps":["trace[2076501790] 'agreement among raft nodes before linearized reading'  (duration: 223.612518ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:45.961068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.195431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-01T20:09:45.961143Z","caller":"traceutil/trace.go:171","msg":"trace[2020023369] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:27353; }","duration":"132.318774ms","start":"2026-10-01T20:09:45.828806Z","end":"2026-10-01T20:09:45.961125Z","steps":["trace[2020023369] 'agreement among raft nodes before linearized reading'  (duration: 132.210822ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:09:45.961467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.235885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-01T20:09:45.961641Z","caller":"traceutil/trace.go:171","msg":"trace[756837142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27353; }","duration":"175.91874ms","start":"2026-10-01T20:09:45.78571Z","end":"2026-10-01T20:09:45.961629Z","steps":["trace[756837142] 'agreement among raft nodes before linearized reading'  (duration: 175.219815ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:09:51.367644Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24508}
{"level":"info","ts":"2026-10-01T20:09:51.516308Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24508,"took":"144.713342ms","hash":3401398287,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":36851712,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-10-01T20:09:51.516389Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3401398287,"revision":24508,"compact-revision":21591}
{"level":"info","ts":"2026-10-01T20:10:04.109753Z","caller":"traceutil/trace.go:171","msg":"trace[1461781805] transaction","detail":"{read_only:false; response_revision:27511; number_of_response:1; }","duration":"140.304892ms","start":"2026-10-01T20:10:03.969422Z","end":"2026-10-01T20:10:04.109727Z","steps":["trace[1461781805] 'process raft request'  (duration: 140.150259ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:04.410612Z","caller":"traceutil/trace.go:171","msg":"trace[303157597] transaction","detail":"{read_only:false; response_revision:27512; number_of_response:1; }","duration":"440.649938ms","start":"2026-10-01T20:10:03.969918Z","end":"2026-10-01T20:10:04.410568Z","steps":["trace[303157597] 'process raft request'  (duration: 341.724043ms)","trace[303157597] 'compare'  (duration: 98.428624ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:10:04.410687Z","caller":"traceutil/trace.go:171","msg":"trace[349831759] linearizableReadLoop","detail":"{readStateIndex:28415; appliedIndex:28411; }","duration":"157.155519ms","start":"2026-10-01T20:10:04.253511Z","end":"2026-10-01T20:10:04.410666Z","steps":["trace[349831759] 'read index received'  (duration: 58.155553ms)","trace[349831759] 'applied index is now lower than readState.Index'  (duration: 98.998976ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:10:04.410767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:10:03.969893Z","time spent":"440.789371ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:27496 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-10-01T20:10:04.410775Z","caller":"traceutil/trace.go:171","msg":"trace[1416665079] transaction","detail":"{read_only:false; response_revision:27513; number_of_response:1; }","duration":"440.556657ms","start":"2026-10-01T20:10:03.970208Z","end":"2026-10-01T20:10:04.410765Z","steps":["trace[1416665079] 'process raft request'  (duration: 440.28924ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.410875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:10:03.970152Z","time spent":"440.650959ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:27498 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-01T20:10:04.410965Z","caller":"traceutil/trace.go:171","msg":"trace[1715288070] transaction","detail":"{read_only:false; response_revision:27515; number_of_response:1; }","duration":"318.958753ms","start":"2026-10-01T20:10:04.091969Z","end":"2026-10-01T20:10:04.410927Z","steps":["trace[1715288070] 'process raft request'  (duration: 318.657646ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.411055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.552079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-01T20:10:04.411086Z","caller":"traceutil/trace.go:171","msg":"trace[1435299853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27515; }","duration":"157.61914ms","start":"2026-10-01T20:10:04.253457Z","end":"2026-10-01T20:10:04.411077Z","steps":["trace[1435299853] 'agreement among raft nodes before linearized reading'  (duration: 157.514458ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.411126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:10:04.091916Z","time spent":"319.121977ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:27500 > 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":"info","ts":"2026-10-01T20:10:04.411162Z","caller":"traceutil/trace.go:171","msg":"trace[2058976078] transaction","detail":"{read_only:false; response_revision:27514; number_of_response:1; }","duration":"382.901975ms","start":"2026-10-01T20:10:04.028253Z","end":"2026-10-01T20:10:04.411155Z","steps":["trace[2058976078] 'process raft request'  (duration: 382.332582ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.411266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T20:10:04.028219Z","time spent":"383.011168ms","remote":"127.0.0.1:45664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:27499 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-10-01T20:10:04.693876Z","caller":"traceutil/trace.go:171","msg":"trace[382505375] linearizableReadLoop","detail":"{readStateIndex:28417; appliedIndex:28416; }","duration":"283.09317ms","start":"2026-10-01T20:10:04.410739Z","end":"2026-10-01T20:10:04.693833Z","steps":["trace[382505375] 'read index received'  (duration: 19.401044ms)","trace[382505375] 'applied index is now lower than readState.Index'  (duration: 263.691066ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:10:04.694054Z","caller":"traceutil/trace.go:171","msg":"trace[735020735] transaction","detail":"{read_only:false; response_revision:27517; number_of_response:1; }","duration":"285.729859ms","start":"2026-10-01T20:10:04.408292Z","end":"2026-10-01T20:10:04.694022Z","steps":["trace[735020735] 'process raft request'  (duration: 231.545925ms)","trace[735020735] 'compare'  (duration: 53.815615ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:10:04.694137Z","caller":"traceutil/trace.go:171","msg":"trace[1508490892] transaction","detail":"{read_only:false; response_revision:27518; number_of_response:1; }","duration":"277.845103ms","start":"2026-10-01T20:10:04.416238Z","end":"2026-10-01T20:10:04.694083Z","steps":["trace[1508490892] 'process raft request'  (duration: 277.545757ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.694187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.996051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-10-01T20:10:04.694222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.426756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"warn","ts":"2026-10-01T20:10:04.694232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.980768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-10-01T20:10:04.694269Z","caller":"traceutil/trace.go:171","msg":"trace[775444719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27518; }","duration":"284.119613ms","start":"2026-10-01T20:10:04.41013Z","end":"2026-10-01T20:10:04.69425Z","steps":["trace[775444719] 'agreement among raft nodes before linearized reading'  (duration: 283.878638ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:04.694315Z","caller":"traceutil/trace.go:171","msg":"trace[43521532] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:27518; }","duration":"132.533919ms","start":"2026-10-01T20:10:04.56174Z","end":"2026-10-01T20:10:04.694274Z","steps":["trace[43521532] 'agreement among raft nodes before linearized reading'  (duration: 132.309274ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:04.694336Z","caller":"traceutil/trace.go:171","msg":"trace[614819015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27518; }","duration":"204.102401ms","start":"2026-10-01T20:10:04.490187Z","end":"2026-10-01T20:10:04.69429Z","steps":["trace[614819015] 'agreement among raft nodes before linearized reading'  (duration: 203.863566ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.694574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.816186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-01T20:10:04.694703Z","caller":"traceutil/trace.go:171","msg":"trace[1540939335] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27518; }","duration":"191.99165ms","start":"2026-10-01T20:10:04.502683Z","end":"2026-10-01T20:10:04.694675Z","steps":["trace[1540939335] 'agreement among raft nodes before linearized reading'  (duration: 191.563481ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.961027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.544373ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4787221919756696683 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:27506 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-01T20:10:04.961274Z","caller":"traceutil/trace.go:171","msg":"trace[1499355398] transaction","detail":"{read_only:false; response_revision:27522; number_of_response:1; }","duration":"259.39333ms","start":"2026-10-01T20:10:04.701862Z","end":"2026-10-01T20:10:04.961255Z","steps":["trace[1499355398] 'process raft request'  (duration: 259.356919ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:04.961519Z","caller":"traceutil/trace.go:171","msg":"trace[2146534091] transaction","detail":"{read_only:false; response_revision:27519; number_of_response:1; }","duration":"261.901915ms","start":"2026-10-01T20:10:04.699605Z","end":"2026-10-01T20:10:04.961507Z","steps":["trace[2146534091] 'process raft request'  (duration: 126.8261ms)","trace[2146534091] 'compare'  (duration: 134.37541ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:10:04.961647Z","caller":"traceutil/trace.go:171","msg":"trace[250644688] linearizableReadLoop","detail":"{readStateIndex:28419; appliedIndex:28418; }","duration":"260.999495ms","start":"2026-10-01T20:10:04.700638Z","end":"2026-10-01T20:10:04.961637Z","steps":["trace[250644688] 'read index received'  (duration: 125.776007ms)","trace[250644688] 'applied index is now lower than readState.Index'  (duration: 135.222458ms)"],"step_count":2}
{"level":"info","ts":"2026-10-01T20:10:04.961923Z","caller":"traceutil/trace.go:171","msg":"trace[1368184658] transaction","detail":"{read_only:false; response_revision:27520; number_of_response:1; }","duration":"261.054707ms","start":"2026-10-01T20:10:04.700839Z","end":"2026-10-01T20:10:04.961893Z","steps":["trace[1368184658] 'process raft request'  (duration: 260.29208ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:04.961955Z","caller":"traceutil/trace.go:171","msg":"trace[1353775704] transaction","detail":"{read_only:false; response_revision:27521; number_of_response:1; }","duration":"260.215317ms","start":"2026-10-01T20:10:04.701707Z","end":"2026-10-01T20:10:04.961923Z","steps":["trace[1353775704] 'process raft request'  (duration: 259.473611ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:04.962043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.394454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-41694e4b-21b7-4f7c-89c0-a35e89bee9ff\" ","response":"range_response_count:1 size:1319"}
{"level":"info","ts":"2026-10-01T20:10:04.962099Z","caller":"traceutil/trace.go:171","msg":"trace[1223203633] range","detail":"{range_begin:/registry/persistentvolumes/pvc-41694e4b-21b7-4f7c-89c0-a35e89bee9ff; range_end:; response_count:1; response_revision:27522; }","duration":"261.478576ms","start":"2026-10-01T20:10:04.700604Z","end":"2026-10-01T20:10:04.962083Z","steps":["trace[1223203633] 'agreement among raft nodes before linearized reading'  (duration: 261.308642ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:05.024074Z","caller":"traceutil/trace.go:171","msg":"trace[428419991] transaction","detail":"{read_only:false; response_revision:27523; number_of_response:1; }","duration":"139.007572ms","start":"2026-10-01T20:10:04.885032Z","end":"2026-10-01T20:10:05.02404Z","steps":["trace[428419991] 'process raft request'  (duration: 138.699705ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-01T20:10:05.024155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.038864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.211\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-10-01T20:10:05.024226Z","caller":"traceutil/trace.go:171","msg":"trace[290233649] range","detail":"{range_begin:/registry/masterleases/162.253.55.211; range_end:; response_count:1; response_revision:27523; }","duration":"206.158486ms","start":"2026-10-01T20:10:04.818048Z","end":"2026-10-01T20:10:05.024207Z","steps":["trace[290233649] 'agreement among raft nodes before linearized reading'  (duration: 205.824059ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:10:05.193643Z","caller":"traceutil/trace.go:171","msg":"trace[106592135] transaction","detail":"{read_only:false; response_revision:27524; number_of_response:1; }","duration":"151.266317ms","start":"2026-10-01T20:10:05.042343Z","end":"2026-10-01T20:10:05.19361Z","steps":["trace[106592135] 'process raft request'  (duration: 66.391777ms)","trace[106592135] 'compare'  (duration: 84.484992ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-01T20:10:05.623749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.875922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-10-01T20:10:05.623878Z","caller":"traceutil/trace.go:171","msg":"trace[182545989] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27524; }","duration":"168.993215ms","start":"2026-10-01T20:10:05.454812Z","end":"2026-10-01T20:10:05.623805Z","steps":["trace[182545989] 'range keys from in-memory index tree'  (duration: 168.731928ms)"],"step_count":1}
{"level":"info","ts":"2026-10-01T20:12:43.621986Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"931f6a422b4c426f","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-01T20:12:43.627771Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-01T20:12:43.627864Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-01T20:14:51.373759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27392}
{"level":"info","ts":"2026-10-01T20:14:51.510835Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27392,"took":"133.025579ms","hash":1904013973,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":37969920,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-10-01T20:14:51.511002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1904013973,"revision":27392,"compact-revision":24508}
{"level":"info","ts":"2026-10-01T20:19:51.381015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30275}
{"level":"info","ts":"2026-10-01T20:19:51.530395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30275,"took":"145.343743ms","hash":776558893,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":31793152,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-01T20:19:51.530475Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":776558893,"revision":30275,"compact-revision":27392}
{"level":"info","ts":"2026-10-01T20:24:51.388958Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32534}
{"level":"info","ts":"2026-10-01T20:24:51.547586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32534,"took":"152.924815ms","hash":3317433356,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":31313920,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-01T20:24:51.547666Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3317433356,"revision":32534,"compact-revision":30275}
{"level":"info","ts":"2026-10-01T20:29:51.396832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34761}
{"level":"info","ts":"2026-10-01T20:29:51.554181Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34761,"took":"146.783088ms","hash":2516662973,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":31948800,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-01T20:29:51.554243Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2516662973,"revision":34761,"compact-revision":32534}
{"level":"info","ts":"2026-10-01T20:33:36.013882Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"931f6a422b4c426f","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-01T20:33:36.021397Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-01T20:33:36.021598Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-01T20:34:51.404867Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37031}
{"level":"info","ts":"2026-10-01T20:34:51.555025Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37031,"took":"142.365497ms","hash":3354093906,"current-db-size-bytes":60215296,"current-db-size":"60 MB","current-db-size-in-use-bytes":33091584,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-01T20:34:51.555117Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3354093906,"revision":37031,"compact-revision":34761}
{"level":"info","ts":"2026-10-01T20:39:51.413968Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39341}
{"level":"info","ts":"2026-10-01T20:39:51.558091Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39341,"took":"136.875145ms","hash":3750949545,"current-db-size-bytes":60215296,"current-db-size":"60 MB","current-db-size-in-use-bytes":30871552,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-01T20:39:51.558168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3750949545,"revision":39341,"compact-revision":37031}
{"level":"info","ts":"2026-10-01T20:44:51.422568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41571}
{"level":"info","ts":"2026-10-01T20:44:51.554103Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41571,"took":"125.910089ms","hash":513318772,"current-db-size-bytes":60215296,"current-db-size":"60 MB","current-db-size-in-use-bytes":30007296,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-01T20:44:51.554208Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":513318772,"revision":41571,"compact-revision":39341}
{"level":"info","ts":"2026-10-01T20:49:51.429767Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":43798}
{"level":"info","ts":"2026-10-01T20:49:51.579734Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":43798,"took":"144.600457ms","hash":1425731268,"current-db-size-bytes":60215296,"current-db-size":"60 MB","current-db-size-in-use-bytes":29773824,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-01T20:49:51.579823Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1425731268,"revision":43798,"compact-revision":41571}
{"level":"info","ts":"2026-10-01T20:54:51.436507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":46082}
{"level":"info","ts":"2026-10-01T20:54:51.57549Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":46082,"took":"133.362405ms","hash":2043597949,"current-db-size-bytes":60215296,"current-db-size":"60 MB","current-db-size-in-use-bytes":29667328,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-01T20:54:51.575559Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2043597949,"revision":46082,"compact-revision":43798}