{"level":"warn","ts":"2026-09-12T01:08:26.044752Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-12T01:08:26.044923Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.111: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.111:2380","--initial-cluster=instance=https://162.253.55.111:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.111:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.111: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-09-12T01:08:26.045055Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-12T01:08:26.045078Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.111:2380"]}
{"level":"info","ts":"2026-09-12T01:08:26.045116Z","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-09-12T01:08:26.046382Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"]}
{"level":"info","ts":"2026-09-12T01:08:26.046541Z","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.111:2380"],"listen-peer-urls":["https://162.253.55.111:2380"],"advertise-client-urls":["https://162.253.55.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.111: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-09-12T01:08:26.051293Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.284711ms"}
{"level":"info","ts":"2026-09-12T01:08:26.061694Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"299bf3744060cbd","cluster-id":"83d94f04ddaf7996"}
{"level":"info","ts":"2026-09-12T01:08:26.061862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=()"}
{"level":"info","ts":"2026-09-12T01:08:26.061964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became follower at term 0"}
{"level":"info","ts":"2026-09-12T01:08:26.062043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 299bf3744060cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-12T01:08:26.062079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became follower at term 1"}
{"level":"info","ts":"2026-09-12T01:08:26.062249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=(187391103597939901)"}
{"level":"warn","ts":"2026-09-12T01:08:26.06941Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-12T01:08:26.073136Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-12T01:08:26.074608Z","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-09-12T01:08:26.079381Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"299bf3744060cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-12T01:08:26.079761Z","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-09-12T01:08:26.079932Z","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-09-12T01:08:26.079815Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"299bf3744060cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-12T01:08:26.079956Z","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-09-12T01:08:26.08071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=(187391103597939901)"}
{"level":"info","ts":"2026-09-12T01:08:26.080936Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"83d94f04ddaf7996","local-member-id":"299bf3744060cbd","added-peer-id":"299bf3744060cbd","added-peer-peer-urls":["https://162.253.55.111:2380"]}
{"level":"info","ts":"2026-09-12T01:08:26.084908Z","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-09-12T01:08:26.085036Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.111:2380"}
{"level":"info","ts":"2026-09-12T01:08:26.085075Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.111:2380"}
{"level":"info","ts":"2026-09-12T01:08:26.085423Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"299bf3744060cbd","initial-advertise-peer-urls":["https://162.253.55.111:2380"],"listen-peer-urls":["https://162.253.55.111:2380"],"advertise-client-urls":["https://162.253.55.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-12T01:08:26.085502Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-12T01:08:26.56332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd is starting a new election at term 1"}
{"level":"info","ts":"2026-09-12T01:08:26.563439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-12T01:08:26.563502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd received MsgPreVoteResp from 299bf3744060cbd at term 1"}
{"level":"info","ts":"2026-09-12T01:08:26.56354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became candidate at term 2"}
{"level":"info","ts":"2026-09-12T01:08:26.563563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd received MsgVoteResp from 299bf3744060cbd at term 2"}
{"level":"info","ts":"2026-09-12T01:08:26.563589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became leader at term 2"}
{"level":"info","ts":"2026-09-12T01:08:26.563622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 299bf3744060cbd elected leader 299bf3744060cbd at term 2"}
{"level":"info","ts":"2026-09-12T01:08:26.56458Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T01:08:26.565657Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-12T01:08:26.56566Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"299bf3744060cbd","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.111:2379]}","request-path":"/0/members/299bf3744060cbd/attributes","cluster-id":"83d94f04ddaf7996","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-12T01:08:26.565702Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-12T01:08:26.566098Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"83d94f04ddaf7996","local-member-id":"299bf3744060cbd","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T01:08:26.56609Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-12T01:08:26.566321Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-12T01:08:26.566248Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T01:08:26.566396Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-12T01:08:26.568261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-12T01:08:26.574347Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.111:2379"}
{"level":"info","ts":"2026-09-12T01:09:15.75708Z","caller":"traceutil/trace.go:171","msg":"trace[1132573293] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"133.277648ms","start":"2026-09-12T01:09:15.623767Z","end":"2026-09-12T01:09:15.757045Z","steps":["trace[1132573293] 'process raft request'  (duration: 132.573724ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:09:16.170185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.912057ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955091810 > lease_revoke:<id:0cbda0932897523d>","response":"size:28"}
{"level":"info","ts":"2026-09-12T01:09:16.170338Z","caller":"traceutil/trace.go:171","msg":"trace[571912679] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"376.140823ms","start":"2026-09-12T01:09:15.794179Z","end":"2026-09-12T01:09:16.17032Z","steps":["trace[571912679] 'read index received'  (duration: 76.372µs)","trace[571912679] 'applied index is now lower than readState.Index'  (duration: 376.063031ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:09:16.170532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.337817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:09:16.170702Z","caller":"traceutil/trace.go:171","msg":"trace[1658590285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"376.553801ms","start":"2026-09-12T01:09:15.794111Z","end":"2026-09-12T01:09:16.170664Z","steps":["trace[1658590285] 'agreement among raft nodes before linearized reading'  (duration: 376.270275ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:09:16.170781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:09:15.794081Z","time spent":"376.684714ms","remote":"127.0.0.1:52312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-12T01:09:16.170873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.161805ms","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-09-12T01:09:16.17117Z","caller":"traceutil/trace.go:171","msg":"trace[1330847915] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:644; }","duration":"109.237197ms","start":"2026-09-12T01:09:16.061903Z","end":"2026-09-12T01:09:16.17114Z","steps":["trace[1330847915] 'range keys from in-memory index tree'  (duration: 108.131884ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:09:16.2198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.788966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-09-12T01:09:16.219884Z","caller":"traceutil/trace.go:171","msg":"trace[1321811051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"122.927739ms","start":"2026-09-12T01:09:16.096936Z","end":"2026-09-12T01:09:16.219864Z","steps":["trace[1321811051] 'agreement among raft nodes before linearized reading'  (duration: 122.671563ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:09:16.219842Z","caller":"traceutil/trace.go:171","msg":"trace[722836446] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"380.68993ms","start":"2026-09-12T01:09:15.839069Z","end":"2026-09-12T01:09:16.219759Z","steps":["trace[722836446] 'process raft request'  (duration: 380.287361ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:09:16.2207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:09:15.839046Z","time spent":"380.932925ms","remote":"127.0.0.1:52694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"info","ts":"2026-09-12T01:09:17.533754Z","caller":"traceutil/trace.go:171","msg":"trace[2126746727] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"104.6373ms","start":"2026-09-12T01:09:17.429086Z","end":"2026-09-12T01:09:17.533723Z","steps":["trace[2126746727] 'process raft request'  (duration: 98.838726ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:09:31.58051Z","caller":"traceutil/trace.go:171","msg":"trace[1088364889] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"156.951403ms","start":"2026-09-12T01:09:31.423534Z","end":"2026-09-12T01:09:31.580486Z","steps":["trace[1088364889] 'process raft request'  (duration: 156.76713ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.165912Z","caller":"traceutil/trace.go:171","msg":"trace[198448000] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"259.700319ms","start":"2026-09-12T01:10:52.906184Z","end":"2026-09-12T01:10:53.165884Z","steps":["trace[198448000] 'read index received'  (duration: 259.485465ms)","trace[198448000] 'applied index is now lower than readState.Index'  (duration: 212.384µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:10:53.165976Z","caller":"traceutil/trace.go:171","msg":"trace[774742007] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"302.051844ms","start":"2026-09-12T01:10:52.863895Z","end":"2026-09-12T01:10:53.165946Z","steps":["trace[774742007] 'process raft request'  (duration: 301.829669ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:10:53.166167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.976876ms","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-09-12T01:10:53.166199Z","caller":"traceutil/trace.go:171","msg":"trace[1584679336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1895; }","duration":"260.069168ms","start":"2026-09-12T01:10:52.906119Z","end":"2026-09-12T01:10:53.166188Z","steps":["trace[1584679336] 'agreement among raft nodes before linearized reading'  (duration: 259.914445ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:10:53.166491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.107805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-09-12T01:10:53.166533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:52.863871Z","time spent":"302.157135ms","remote":"127.0.0.1:52526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1845 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10910 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"info","ts":"2026-09-12T01:10:53.166694Z","caller":"traceutil/trace.go:171","msg":"trace[172064091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1895; }","duration":"257.294089ms","start":"2026-09-12T01:10:52.909304Z","end":"2026-09-12T01:10:53.166598Z","steps":["trace[172064091] 'agreement among raft nodes before linearized reading'  (duration: 256.88296ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.324276Z","caller":"traceutil/trace.go:171","msg":"trace[1285105096] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"152.136416ms","start":"2026-09-12T01:10:53.172119Z","end":"2026-09-12T01:10:53.324256Z","steps":["trace[1285105096] 'process raft request'  (duration: 120.643164ms)","trace[1285105096] 'compare'  (duration: 31.345709ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:10:53.324802Z","caller":"traceutil/trace.go:171","msg":"trace[1194002500] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"152.422971ms","start":"2026-09-12T01:10:53.172349Z","end":"2026-09-12T01:10:53.324772Z","steps":["trace[1194002500] 'process raft request'  (duration: 151.851539ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.325154Z","caller":"traceutil/trace.go:171","msg":"trace[939031987] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"152.732928ms","start":"2026-09-12T01:10:53.17239Z","end":"2026-09-12T01:10:53.325123Z","steps":["trace[939031987] 'process raft request'  (duration: 152.130505ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.325192Z","caller":"traceutil/trace.go:171","msg":"trace[304000292] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"152.246108ms","start":"2026-09-12T01:10:53.172929Z","end":"2026-09-12T01:10:53.325175Z","steps":["trace[304000292] 'process raft request'  (duration: 151.996703ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.325351Z","caller":"traceutil/trace.go:171","msg":"trace[1453464030] linearizableReadLoop","detail":"{readStateIndex:1972; appliedIndex:1967; }","duration":"136.109713ms","start":"2026-09-12T01:10:53.189225Z","end":"2026-09-12T01:10:53.325334Z","steps":["trace[1453464030] 'read index received'  (duration: 103.639521ms)","trace[1453464030] 'applied index is now lower than readState.Index'  (duration: 32.468802ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:10:53.325572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.461417ms","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-09-12T01:10:53.325643Z","caller":"traceutil/trace.go:171","msg":"trace[1880470213] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1901; }","duration":"140.62058ms","start":"2026-09-12T01:10:53.184982Z","end":"2026-09-12T01:10:53.325603Z","steps":["trace[1880470213] 'agreement among raft nodes before linearized reading'  (duration: 140.407635ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.325483Z","caller":"traceutil/trace.go:171","msg":"trace[1310022182] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"152.34004ms","start":"2026-09-12T01:10:53.173077Z","end":"2026-09-12T01:10:53.325417Z","steps":["trace[1310022182] 'process raft request'  (duration: 152.045674ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.346812Z","caller":"traceutil/trace.go:171","msg":"trace[1559965860] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"149.887958ms","start":"2026-09-12T01:10:53.196893Z","end":"2026-09-12T01:10:53.346781Z","steps":["trace[1559965860] 'process raft request'  (duration: 149.654033ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:10:53.64493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.394825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-09-12T01:10:53.64501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.650067ms","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-09-12T01:10:53.645037Z","caller":"traceutil/trace.go:171","msg":"trace[1269566091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1902; }","duration":"118.552299ms","start":"2026-09-12T01:10:53.52646Z","end":"2026-09-12T01:10:53.645012Z","steps":["trace[1269566091] 'range keys from in-memory index tree'  (duration: 118.185571ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:10:53.645061Z","caller":"traceutil/trace.go:171","msg":"trace[746837934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1902; }","duration":"153.759181ms","start":"2026-09-12T01:10:53.491288Z","end":"2026-09-12T01:10:53.645047Z","steps":["trace[746837934] 'range keys from in-memory index tree'  (duration: 153.451613ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:11:06.347556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.752492ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955094529 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1999 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-12T01:11:06.347809Z","caller":"traceutil/trace.go:171","msg":"trace[281273415] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"175.519635ms","start":"2026-09-12T01:11:06.172252Z","end":"2026-09-12T01:11:06.347771Z","steps":["trace[281273415] 'process raft request'  (duration: 27.426186ms)","trace[281273415] 'compare'  (duration: 147.546478ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:11:09.980116Z","caller":"traceutil/trace.go:171","msg":"trace[143185188] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"177.384014ms","start":"2026-09-12T01:11:09.802703Z","end":"2026-09-12T01:11:09.980087Z","steps":["trace[143185188] 'process raft request'  (duration: 177.336533ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:11:09.980165Z","caller":"traceutil/trace.go:171","msg":"trace[1508212329] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"178.398395ms","start":"2026-09-12T01:11:09.801724Z","end":"2026-09-12T01:11:09.980123Z","steps":["trace[1508212329] 'process raft request'  (duration: 142.393227ms)","trace[1508212329] 'compare'  (duration: 35.772793ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:11:48.725598Z","caller":"traceutil/trace.go:171","msg":"trace[1733921215] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"126.121531ms","start":"2026-09-12T01:11:48.599446Z","end":"2026-09-12T01:11:48.725567Z","steps":["trace[1733921215] 'process raft request'  (duration: 125.645641ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:11:48.846866Z","caller":"traceutil/trace.go:171","msg":"trace[1495455949] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"116.139768ms","start":"2026-09-12T01:11:48.730666Z","end":"2026-09-12T01:11:48.846806Z","steps":["trace[1495455949] 'process raft request'  (duration: 104.032599ms)","trace[1495455949] 'compare'  (duration: 11.578007ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:12:24.539733Z","caller":"traceutil/trace.go:171","msg":"trace[954466597] linearizableReadLoop","detail":"{readStateIndex:2716; appliedIndex:2715; }","duration":"107.619157ms","start":"2026-09-12T01:12:24.432076Z","end":"2026-09-12T01:12:24.539695Z","steps":["trace[954466597] 'read index received'  (duration: 107.359161ms)","trace[954466597] 'applied index is now lower than readState.Index'  (duration: 258.516µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:12:24.539884Z","caller":"traceutil/trace.go:171","msg":"trace[492659256] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"110.134049ms","start":"2026-09-12T01:12:24.429652Z","end":"2026-09-12T01:12:24.539786Z","steps":["trace[492659256] 'process raft request'  (duration: 109.761011ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:12:24.540092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.987684ms","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-09-12T01:12:24.540137Z","caller":"traceutil/trace.go:171","msg":"trace[102553966] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2619; }","duration":"108.115587ms","start":"2026-09-12T01:12:24.432008Z","end":"2026-09-12T01:12:24.540123Z","steps":["trace[102553966] 'agreement among raft nodes before linearized reading'  (duration: 107.886432ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:12:25.4147Z","caller":"traceutil/trace.go:171","msg":"trace[1191568796] linearizableReadLoop","detail":"{readStateIndex:2722; appliedIndex:2721; }","duration":"166.290165ms","start":"2026-09-12T01:12:25.248375Z","end":"2026-09-12T01:12:25.414665Z","steps":["trace[1191568796] 'read index received'  (duration: 166.158472ms)","trace[1191568796] 'applied index is now lower than readState.Index'  (duration: 130.233µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:12:25.414732Z","caller":"traceutil/trace.go:171","msg":"trace[1004500485] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"190.183081ms","start":"2026-09-12T01:12:25.224519Z","end":"2026-09-12T01:12:25.414702Z","steps":["trace[1004500485] 'process raft request'  (duration: 189.922635ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:12:25.414938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.547371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-12T01:12:25.414974Z","caller":"traceutil/trace.go:171","msg":"trace[1402503354] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2625; }","duration":"166.657692ms","start":"2026-09-12T01:12:25.248311Z","end":"2026-09-12T01:12:25.414969Z","steps":["trace[1402503354] 'agreement among raft nodes before linearized reading'  (duration: 166.474359ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:12:58.259471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.174389ms","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-09-12T01:12:58.259618Z","caller":"traceutil/trace.go:171","msg":"trace[1558551835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2823; }","duration":"201.403733ms","start":"2026-09-12T01:12:58.05819Z","end":"2026-09-12T01:12:58.259593Z","steps":["trace[1558551835] 'range keys from in-memory index tree'  (duration: 200.896173ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:16:17.196605Z","caller":"traceutil/trace.go:171","msg":"trace[1992353248] transaction","detail":"{read_only:false; response_revision:4070; number_of_response:1; }","duration":"134.07895ms","start":"2026-09-12T01:16:17.062502Z","end":"2026-09-12T01:16:17.196581Z","steps":["trace[1992353248] 'process raft request'  (duration: 133.927897ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:16:17.238395Z","caller":"traceutil/trace.go:171","msg":"trace[1929861150] transaction","detail":"{read_only:false; response_revision:4071; number_of_response:1; }","duration":"132.525866ms","start":"2026-09-12T01:16:17.105835Z","end":"2026-09-12T01:16:17.238361Z","steps":["trace[1929861150] 'process raft request'  (duration: 132.306551ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:17:50.44555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.239334ms","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-09-12T01:17:50.445682Z","caller":"traceutil/trace.go:171","msg":"trace[812281527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5110; }","duration":"107.426338ms","start":"2026-09-12T01:17:50.338233Z","end":"2026-09-12T01:17:50.445659Z","steps":["trace[812281527] 'range keys from in-memory index tree'  (duration: 107.0201ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:11.604663Z","caller":"traceutil/trace.go:171","msg":"trace[474650950] linearizableReadLoop","detail":"{readStateIndex:5786; appliedIndex:5785; }","duration":"112.431295ms","start":"2026-09-12T01:18:11.492197Z","end":"2026-09-12T01:18:11.604628Z","steps":["trace[474650950] 'read index received'  (duration: 112.040347ms)","trace[474650950] 'applied index is now lower than readState.Index'  (duration: 389.508µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:18:11.604732Z","caller":"traceutil/trace.go:171","msg":"trace[1989675737] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"132.710997ms","start":"2026-09-12T01:18:11.471967Z","end":"2026-09-12T01:18:11.604678Z","steps":["trace[1989675737] 'process raft request'  (duration: 132.321529ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:18:11.604972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.742291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-vhkvm\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-09-12T01:18:11.605035Z","caller":"traceutil/trace.go:171","msg":"trace[815542559] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-vhkvm; range_end:; response_count:1; response_revision:5576; }","duration":"112.845564ms","start":"2026-09-12T01:18:11.492171Z","end":"2026-09-12T01:18:11.605016Z","steps":["trace[815542559] 'agreement among raft nodes before linearized reading'  (duration: 112.588888ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:11.740139Z","caller":"traceutil/trace.go:171","msg":"trace[708333838] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"133.026663ms","start":"2026-09-12T01:18:11.607067Z","end":"2026-09-12T01:18:11.740094Z","steps":["trace[708333838] 'process raft request'  (duration: 85.217495ms)","trace[708333838] 'compare'  (duration: 47.579984ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:18:11.758158Z","caller":"traceutil/trace.go:171","msg":"trace[25338160] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"140.935162ms","start":"2026-09-12T01:18:11.617196Z","end":"2026-09-12T01:18:11.758131Z","steps":["trace[25338160] 'process raft request'  (duration: 140.791219ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:18:12.123309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.929745ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955103085 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18d46dfe809b7fa8\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18d46dfe809b7fa8\" value_size:682 lease:918066452955102247 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-12T01:18:12.123521Z","caller":"traceutil/trace.go:171","msg":"trace[1944149088] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"186.001332ms","start":"2026-09-12T01:18:11.937504Z","end":"2026-09-12T01:18:12.123506Z","steps":["trace[1944149088] 'process raft request'  (duration: 185.975192ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:12.123508Z","caller":"traceutil/trace.go:171","msg":"trace[1869531174] linearizableReadLoop","detail":"{readStateIndex:5796; appliedIndex:5795; }","duration":"288.415045ms","start":"2026-09-12T01:18:11.835062Z","end":"2026-09-12T01:18:12.123477Z","steps":["trace[1869531174] 'read index received'  (duration: 38.199064ms)","trace[1869531174] 'applied index is now lower than readState.Index'  (duration: 250.212181ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:18:12.123764Z","caller":"traceutil/trace.go:171","msg":"trace[752972569] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"225.742719ms","start":"2026-09-12T01:18:11.898013Z","end":"2026-09-12T01:18:12.123756Z","steps":["trace[752972569] 'process raft request'  (duration: 225.391261ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:12.123851Z","caller":"traceutil/trace.go:171","msg":"trace[254903282] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"186.416831ms","start":"2026-09-12T01:18:11.937428Z","end":"2026-09-12T01:18:12.123845Z","steps":["trace[254903282] 'process raft request'  (duration: 186.025652ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:18:12.124045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.761093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-09-12T01:18:12.124046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.984386ms","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-09-12T01:18:12.12407Z","caller":"traceutil/trace.go:171","msg":"trace[806909105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5589; }","duration":"121.842605ms","start":"2026-09-12T01:18:12.00222Z","end":"2026-09-12T01:18:12.124062Z","steps":["trace[806909105] 'agreement among raft nodes before linearized reading'  (duration: 121.734353ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:12.124089Z","caller":"traceutil/trace.go:171","msg":"trace[1927120462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5589; }","duration":"289.090088ms","start":"2026-09-12T01:18:11.834983Z","end":"2026-09-12T01:18:12.124073Z","steps":["trace[1927120462] 'agreement among raft nodes before linearized reading'  (duration: 288.850913ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:12.124642Z","caller":"traceutil/trace.go:171","msg":"trace[1767635902] transaction","detail":"{read_only:false; response_revision:5586; number_of_response:1; }","duration":"300.854099ms","start":"2026-09-12T01:18:11.823749Z","end":"2026-09-12T01:18:12.124603Z","steps":["trace[1767635902] 'process raft request'  (duration: 49.566156ms)","trace[1767635902] 'compare'  (duration: 249.832122ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:18:12.124916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:18:11.823721Z","time spent":"301.100375ms","remote":"127.0.0.1:52396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18d46dfe809b7fa8\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18d46dfe809b7fa8\" value_size:682 lease:918066452955102247 >> failure:<>"}
{"level":"warn","ts":"2026-09-12T01:18:12.404713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.382704ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955103091 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5538 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-12T01:18:12.404829Z","caller":"traceutil/trace.go:171","msg":"trace[1275402188] transaction","detail":"{read_only:false; response_revision:5590; number_of_response:1; }","duration":"275.156193ms","start":"2026-09-12T01:18:12.129653Z","end":"2026-09-12T01:18:12.404809Z","steps":["trace[1275402188] 'process raft request'  (duration: 109.588875ms)","trace[1275402188] 'compare'  (duration: 165.236891ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:18:12.435595Z","caller":"traceutil/trace.go:171","msg":"trace[780105708] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"305.637891ms","start":"2026-09-12T01:18:12.129916Z","end":"2026-09-12T01:18:12.435554Z","steps":["trace[780105708] 'process raft request'  (duration: 305.328764ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:12.435765Z","caller":"traceutil/trace.go:171","msg":"trace[1081232954] transaction","detail":"{read_only:false; response_revision:5592; number_of_response:1; }","duration":"219.865654ms","start":"2026-09-12T01:18:12.215869Z","end":"2026-09-12T01:18:12.435735Z","steps":["trace[1081232954] 'process raft request'  (duration: 219.607129ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:18:12.435984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:18:12.129888Z","time spent":"305.875346ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5541 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-12T01:18:12.436765Z","caller":"traceutil/trace.go:171","msg":"trace[520826335] transaction","detail":"{read_only:false; response_revision:5593; number_of_response:1; }","duration":"127.764952ms","start":"2026-09-12T01:18:12.308962Z","end":"2026-09-12T01:18:12.436727Z","steps":["trace[520826335] 'process raft request'  (duration: 127.484676ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:18:24.071776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.866963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b3dacda3-f688-4fc4-9007-5d13bc0f75b8\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-09-12T01:18:24.071861Z","caller":"traceutil/trace.go:171","msg":"trace[2099617613] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b3dacda3-f688-4fc4-9007-5d13bc0f75b8; range_end:; response_count:1; response_revision:5821; }","duration":"134.998346ms","start":"2026-09-12T01:18:23.936845Z","end":"2026-09-12T01:18:24.071843Z","steps":["trace[2099617613] 'range keys from in-memory index tree'  (duration: 134.70181ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:24.269737Z","caller":"traceutil/trace.go:171","msg":"trace[814763858] transaction","detail":"{read_only:false; response_revision:5824; number_of_response:1; }","duration":"122.366127ms","start":"2026-09-12T01:18:24.147338Z","end":"2026-09-12T01:18:24.269704Z","steps":["trace[814763858] 'process raft request'  (duration: 121.970459ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:24.270109Z","caller":"traceutil/trace.go:171","msg":"trace[900063215] transaction","detail":"{read_only:false; response_revision:5825; number_of_response:1; }","duration":"122.607392ms","start":"2026-09-12T01:18:24.147483Z","end":"2026-09-12T01:18:24.27009Z","steps":["trace[900063215] 'process raft request'  (duration: 122.144733ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:24.270301Z","caller":"traceutil/trace.go:171","msg":"trace[709553448] transaction","detail":"{read_only:false; response_revision:5827; number_of_response:1; }","duration":"121.045908ms","start":"2026-09-12T01:18:24.149241Z","end":"2026-09-12T01:18:24.270287Z","steps":["trace[709553448] 'process raft request'  (duration: 120.784213ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:24.270385Z","caller":"traceutil/trace.go:171","msg":"trace[1506321962] transaction","detail":"{read_only:false; response_revision:5828; number_of_response:1; }","duration":"107.019909ms","start":"2026-09-12T01:18:24.163303Z","end":"2026-09-12T01:18:24.270323Z","steps":["trace[1506321962] 'process raft request'  (duration: 106.809495ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:24.270717Z","caller":"traceutil/trace.go:171","msg":"trace[306022244] transaction","detail":"{read_only:false; response_revision:5826; number_of_response:1; }","duration":"122.475678ms","start":"2026-09-12T01:18:24.148216Z","end":"2026-09-12T01:18:24.270691Z","steps":["trace[306022244] 'process raft request'  (duration: 121.702352ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:18:26.801288Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2980}
{"level":"info","ts":"2026-09-12T01:18:26.91702Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2980,"took":"114.185193ms","hash":4229231624,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":32411648,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-12T01:18:26.917088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4229231624,"revision":2980,"compact-revision":-1}
{"level":"info","ts":"2026-09-12T01:23:26.808934Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5860}
{"level":"info","ts":"2026-09-12T01:23:26.907224Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5860,"took":"96.170089ms","hash":2048143465,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":25911296,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-12T01:23:26.90732Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2048143465,"revision":5860,"compact-revision":2980}
{"level":"info","ts":"2026-09-12T01:24:52.223528Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000233c.wal"}
{"level":"info","ts":"2026-09-12T01:25:07.779425Z","caller":"traceutil/trace.go:171","msg":"trace[1264814441] transaction","detail":"{read_only:false; response_revision:8793; number_of_response:1; }","duration":"109.373386ms","start":"2026-09-12T01:25:07.670022Z","end":"2026-09-12T01:25:07.779396Z","steps":["trace[1264814441] 'process raft request'  (duration: 66.975384ms)","trace[1264814441] 'compare'  (duration: 42.008274ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:25:08.445453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.527974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955111379 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/barbican-api-57f8f8c9f7-ngj8q.18d46e5ac684a5ba\" mod_revision:8745 > success:<request_put:<key:\"/registry/events/openstack/barbican-api-57f8f8c9f7-ngj8q.18d46e5ac684a5ba\" value_size:1029 lease:918066452955110583 >> failure:<request_range:<key:\"/registry/events/openstack/barbican-api-57f8f8c9f7-ngj8q.18d46e5ac684a5ba\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-12T01:25:08.445566Z","caller":"traceutil/trace.go:171","msg":"trace[724658925] linearizableReadLoop","detail":"{readStateIndex:9109; appliedIndex:9108; }","duration":"298.617871ms","start":"2026-09-12T01:25:08.146927Z","end":"2026-09-12T01:25:08.445545Z","steps":["trace[724658925] 'read index received'  (duration: 27.853332ms)","trace[724658925] 'applied index is now lower than readState.Index'  (duration: 270.763089ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:25:08.445726Z","caller":"traceutil/trace.go:171","msg":"trace[1929940595] transaction","detail":"{read_only:false; response_revision:8797; number_of_response:1; }","duration":"311.095997ms","start":"2026-09-12T01:25:08.134536Z","end":"2026-09-12T01:25:08.445632Z","steps":["trace[1929940595] 'process raft request'  (duration: 40.292097ms)","trace[1929940595] 'compare'  (duration: 269.962932ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:25:08.445811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.879656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-09-12T01:25:08.445849Z","caller":"traceutil/trace.go:171","msg":"trace[2141580424] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8797; }","duration":"298.940778ms","start":"2026-09-12T01:25:08.146893Z","end":"2026-09-12T01:25:08.445834Z","steps":["trace[2141580424] 'agreement among raft nodes before linearized reading'  (duration: 298.742644ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:25:08.445946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:25:08.134508Z","time spent":"311.318921ms","remote":"127.0.0.1:52396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/barbican-api-57f8f8c9f7-ngj8q.18d46e5ac684a5ba\" mod_revision:8745 > success:<request_put:<key:\"/registry/events/openstack/barbican-api-57f8f8c9f7-ngj8q.18d46e5ac684a5ba\" value_size:1029 lease:918066452955110583 >> failure:<request_range:<key:\"/registry/events/openstack/barbican-api-57f8f8c9f7-ngj8q.18d46e5ac684a5ba\" > >"}
{"level":"warn","ts":"2026-09-12T01:25:08.446089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.981303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:25:08.446124Z","caller":"traceutil/trace.go:171","msg":"trace[1847588198] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:8797; }","duration":"137.073255ms","start":"2026-09-12T01:25:08.309042Z","end":"2026-09-12T01:25:08.446116Z","steps":["trace[1847588198] 'agreement among raft nodes before linearized reading'  (duration: 137.016594ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:25:08.963443Z","caller":"traceutil/trace.go:171","msg":"trace[330548655] transaction","detail":"{read_only:false; response_revision:8799; number_of_response:1; }","duration":"173.314107ms","start":"2026-09-12T01:25:08.790102Z","end":"2026-09-12T01:25:08.963416Z","steps":["trace[330548655] 'process raft request'  (duration: 150.998932ms)","trace[330548655] 'compare'  (duration: 22.169532ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:25:41.433286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.696481ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955112143 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9018 > 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-09-12T01:25:41.433401Z","caller":"traceutil/trace.go:171","msg":"trace[849452030] linearizableReadLoop","detail":"{readStateIndex:9352; appliedIndex:9351; }","duration":"152.054145ms","start":"2026-09-12T01:25:41.281331Z","end":"2026-09-12T01:25:41.433385Z","steps":["trace[849452030] 'read index received'  (duration: 44.107478ms)","trace[849452030] 'applied index is now lower than readState.Index'  (duration: 107.945447ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:25:41.43348Z","caller":"traceutil/trace.go:171","msg":"trace[2131008371] transaction","detail":"{read_only:false; response_revision:9030; number_of_response:1; }","duration":"241.59502ms","start":"2026-09-12T01:25:41.191877Z","end":"2026-09-12T01:25:41.433472Z","steps":["trace[2131008371] 'process raft request'  (duration: 133.605962ms)","trace[2131008371] 'compare'  (duration: 107.469547ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:25:41.433717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.375922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:25:41.433756Z","caller":"traceutil/trace.go:171","msg":"trace[998359224] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:9030; }","duration":"152.478014ms","start":"2026-09-12T01:25:41.281264Z","end":"2026-09-12T01:25:41.433742Z","steps":["trace[998359224] 'agreement among raft nodes before linearized reading'  (duration: 152.380112ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:25:41.433779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.223675ms","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-09-12T01:25:41.433912Z","caller":"traceutil/trace.go:171","msg":"trace[906314116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9030; }","duration":"110.45694ms","start":"2026-09-12T01:25:41.323427Z","end":"2026-09-12T01:25:41.433883Z","steps":["trace[906314116] 'agreement among raft nodes before linearized reading'  (duration: 110.084912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:25:49.791122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.684516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8d9dk\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-12T01:25:49.791223Z","caller":"traceutil/trace.go:171","msg":"trace[1311785813] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8d9dk; range_end:; response_count:1; response_revision:9074; }","duration":"183.83212ms","start":"2026-09-12T01:25:49.607368Z","end":"2026-09-12T01:25:49.7912Z","steps":["trace[1311785813] 'range keys from in-memory index tree'  (duration: 183.446161ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:25:49.876674Z","caller":"traceutil/trace.go:171","msg":"trace[977969164] transaction","detail":"{read_only:false; response_revision:9075; number_of_response:1; }","duration":"106.501055ms","start":"2026-09-12T01:25:49.770133Z","end":"2026-09-12T01:25:49.876634Z","steps":["trace[977969164] 'process raft request'  (duration: 106.27516ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:25:50.729761Z","caller":"traceutil/trace.go:171","msg":"trace[1527025215] transaction","detail":"{read_only:false; response_revision:9081; number_of_response:1; }","duration":"122.141597ms","start":"2026-09-12T01:25:50.607557Z","end":"2026-09-12T01:25:50.729699Z","steps":["trace[1527025215] 'process raft request'  (duration: 121.977294ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:26:25.236189Z","caller":"traceutil/trace.go:171","msg":"trace[1797455005] transaction","detail":"{read_only:false; response_revision:9442; number_of_response:1; }","duration":"110.624063ms","start":"2026-09-12T01:26:25.125533Z","end":"2026-09-12T01:26:25.236157Z","steps":["trace[1797455005] 'process raft request'  (duration: 109.949989ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:26:53.191294Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T01:26:53.203477Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-12T01:26:53.203621Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-12T01:28:26.815589Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8031}
{"level":"info","ts":"2026-09-12T01:28:26.892236Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8031,"took":"73.85588ms","hash":4066534187,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":28626944,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-12T01:28:26.892333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4066534187,"revision":8031,"compact-revision":5860}
{"level":"info","ts":"2026-09-12T01:33:00.22495Z","caller":"traceutil/trace.go:171","msg":"trace[195079750] linearizableReadLoop","detail":"{readStateIndex:12808; appliedIndex:12807; }","duration":"104.171363ms","start":"2026-09-12T01:33:00.120734Z","end":"2026-09-12T01:33:00.224905Z","steps":["trace[195079750] 'read index received'  (duration: 103.868066ms)","trace[195079750] 'applied index is now lower than readState.Index'  (duration: 301.847µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:33:00.225062Z","caller":"traceutil/trace.go:171","msg":"trace[556756793] transaction","detail":"{read_only:false; response_revision:12382; number_of_response:1; }","duration":"154.226669ms","start":"2026-09-12T01:33:00.070809Z","end":"2026-09-12T01:33:00.225036Z","steps":["trace[556756793] 'process raft request'  (duration: 153.912443ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:33:00.22513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.366107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:33:00.225172Z","caller":"traceutil/trace.go:171","msg":"trace[511898744] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:12382; }","duration":"104.467678ms","start":"2026-09-12T01:33:00.120693Z","end":"2026-09-12T01:33:00.225161Z","steps":["trace[511898744] 'agreement among raft nodes before linearized reading'  (duration: 104.370846ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:33:26.835629Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10408}
{"level":"info","ts":"2026-09-12T01:33:26.93277Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10408,"took":"94.498085ms","hash":2452536437,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":25821184,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-12T01:33:26.932838Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2452536437,"revision":10408,"compact-revision":8031}
{"level":"info","ts":"2026-09-12T01:38:26.844854Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12571}
{"level":"info","ts":"2026-09-12T01:38:26.933422Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12571,"took":"86.032832ms","hash":1673052619,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":27443200,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-12T01:38:26.933508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1673052619,"revision":12571,"compact-revision":10408}
{"level":"warn","ts":"2026-09-12T01:39:50.686578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.348029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-12T01:39:50.686699Z","caller":"traceutil/trace.go:171","msg":"trace[1567272990] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:15103; }","duration":"121.532993ms","start":"2026-09-12T01:39:50.565146Z","end":"2026-09-12T01:39:50.686679Z","steps":["trace[1567272990] 'count revisions from in-memory index tree'  (duration: 121.218977ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:40:01.755597Z","caller":"traceutil/trace.go:171","msg":"trace[385700632] transaction","detail":"{read_only:false; response_revision:15278; number_of_response:1; }","duration":"146.467371ms","start":"2026-09-12T01:40:01.609089Z","end":"2026-09-12T01:40:01.755557Z","steps":["trace[385700632] 'process raft request'  (duration: 146.065343ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:40:01.931717Z","caller":"traceutil/trace.go:171","msg":"trace[489625380] linearizableReadLoop","detail":"{readStateIndex:15807; appliedIndex:15805; }","duration":"307.48037ms","start":"2026-09-12T01:40:01.624207Z","end":"2026-09-12T01:40:01.931687Z","steps":["trace[489625380] 'read index received'  (duration: 131.293919ms)","trace[489625380] 'applied index is now lower than readState.Index'  (duration: 176.185661ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:40:01.931827Z","caller":"traceutil/trace.go:171","msg":"trace[942592794] transaction","detail":"{read_only:false; response_revision:15279; number_of_response:1; }","duration":"322.594911ms","start":"2026-09-12T01:40:01.609188Z","end":"2026-09-12T01:40:01.931783Z","steps":["trace[942592794] 'process raft request'  (duration: 322.339875ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:40:01.931952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.090103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-12T01:40:01.931971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.757265ms","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-09-12T01:40:01.932046Z","caller":"traceutil/trace.go:171","msg":"trace[1777080909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15279; }","duration":"138.239317ms","start":"2026-09-12T01:40:01.793783Z","end":"2026-09-12T01:40:01.932022Z","steps":["trace[1777080909] 'agreement among raft nodes before linearized reading'  (duration: 138.089543ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:40:01.932053Z","caller":"traceutil/trace.go:171","msg":"trace[893108290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15279; }","duration":"307.909309ms","start":"2026-09-12T01:40:01.624124Z","end":"2026-09-12T01:40:01.932033Z","steps":["trace[893108290] 'agreement among raft nodes before linearized reading'  (duration: 307.668044ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:40:01.932102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:40:01.624072Z","time spent":"308.019392ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-12T01:40:01.932043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:40:01.609153Z","time spent":"322.785094ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:15164 > 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-09-12T01:41:29.493218Z","caller":"traceutil/trace.go:171","msg":"trace[1797266153] linearizableReadLoop","detail":"{readStateIndex:16854; appliedIndex:16853; }","duration":"174.028345ms","start":"2026-09-12T01:41:29.319163Z","end":"2026-09-12T01:41:29.493191Z","steps":["trace[1797266153] 'read index received'  (duration: 173.78327ms)","trace[1797266153] 'applied index is now lower than readState.Index'  (duration: 243.965µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:41:29.493287Z","caller":"traceutil/trace.go:171","msg":"trace[1162863552] transaction","detail":"{read_only:false; response_revision:16298; number_of_response:1; }","duration":"191.248229ms","start":"2026-09-12T01:41:29.302009Z","end":"2026-09-12T01:41:29.493257Z","steps":["trace[1162863552] 'process raft request'  (duration: 191.003164ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:29.493425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.24076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:41:29.493479Z","caller":"traceutil/trace.go:171","msg":"trace[2107297139] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16298; }","duration":"174.336381ms","start":"2026-09-12T01:41:29.319126Z","end":"2026-09-12T01:41:29.493462Z","steps":["trace[2107297139] 'agreement among raft nodes before linearized reading'  (duration: 174.215988ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:29.493528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.185578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-09-12T01:41:29.493591Z","caller":"traceutil/trace.go:171","msg":"trace[337508319] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16298; }","duration":"174.28885ms","start":"2026-09-12T01:41:29.319286Z","end":"2026-09-12T01:41:29.493575Z","steps":["trace[337508319] 'agreement among raft nodes before linearized reading'  (duration: 174.113977ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:29.493854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.110416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"warn","ts":"2026-09-12T01:41:29.493963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.07868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-09-12T01:41:29.49411Z","caller":"traceutil/trace.go:171","msg":"trace[142651229] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16298; }","duration":"169.264833ms","start":"2026-09-12T01:41:29.324827Z","end":"2026-09-12T01:41:29.494091Z","steps":["trace[142651229] 'agreement among raft nodes before linearized reading'  (duration: 168.988047ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:41:29.494499Z","caller":"traceutil/trace.go:171","msg":"trace[1399300993] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16298; }","duration":"166.210479ms","start":"2026-09-12T01:41:29.32768Z","end":"2026-09-12T01:41:29.49389Z","steps":["trace[1399300993] 'agreement among raft nodes before linearized reading'  (duration: 166.020275ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.544208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.500451ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955132385 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:16293 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-12T01:41:30.544491Z","caller":"traceutil/trace.go:171","msg":"trace[1367818700] linearizableReadLoop","detail":"{readStateIndex:16858; appliedIndex:16857; }","duration":"187.010038ms","start":"2026-09-12T01:41:30.357464Z","end":"2026-09-12T01:41:30.544474Z","steps":["trace[1367818700] 'read index received'  (duration: 7.10915ms)","trace[1367818700] 'applied index is now lower than readState.Index'  (duration: 179.898868ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:41:30.54453Z","caller":"traceutil/trace.go:171","msg":"trace[461939651] transaction","detail":"{read_only:false; response_revision:16302; number_of_response:1; }","duration":"246.53161ms","start":"2026-09-12T01:41:30.297953Z","end":"2026-09-12T01:41:30.544485Z","steps":["trace[461939651] 'process raft request'  (duration: 66.667762ms)","trace[461939651] 'compare'  (duration: 179.141653ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:41:30.54464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.662769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:41:30.54468Z","caller":"traceutil/trace.go:171","msg":"trace[1063437522] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16302; }","duration":"183.726979ms","start":"2026-09-12T01:41:30.360943Z","end":"2026-09-12T01:41:30.54467Z","steps":["trace[1063437522] 'agreement among raft nodes before linearized reading'  (duration: 183.649458ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.5447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.232734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.111\" ","response":"range_response_count:1 size:138"}
{"level":"info","ts":"2026-09-12T01:41:30.54476Z","caller":"traceutil/trace.go:171","msg":"trace[2143183062] range","detail":"{range_begin:/registry/masterleases/162.253.55.111; range_end:; response_count:1; response_revision:16302; }","duration":"187.334437ms","start":"2026-09-12T01:41:30.357411Z","end":"2026-09-12T01:41:30.544745Z","steps":["trace[2143183062] 'agreement among raft nodes before linearized reading'  (duration: 187.150253ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.544968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.140617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-12T01:41:30.545013Z","caller":"traceutil/trace.go:171","msg":"trace[915850290] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:16302; }","duration":"166.223309ms","start":"2026-09-12T01:41:30.378777Z","end":"2026-09-12T01:41:30.545Z","steps":["trace[915850290] 'agreement among raft nodes before linearized reading'  (duration: 166.152838ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.544992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.75304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-09-12T01:41:30.545094Z","caller":"traceutil/trace.go:171","msg":"trace[2082644932] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16302; }","duration":"183.894773ms","start":"2026-09-12T01:41:30.361175Z","end":"2026-09-12T01:41:30.54507Z","steps":["trace[2082644932] 'agreement among raft nodes before linearized reading'  (duration: 183.683018ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.545077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.043564ms","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-09-12T01:41:30.545173Z","caller":"traceutil/trace.go:171","msg":"trace[1889931262] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16302; }","duration":"122.156076ms","start":"2026-09-12T01:41:30.422991Z","end":"2026-09-12T01:41:30.545147Z","steps":["trace[1889931262] 'agreement among raft nodes before linearized reading'  (duration: 121.924161ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.545317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.323323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"}
{"level":"info","ts":"2026-09-12T01:41:30.545437Z","caller":"traceutil/trace.go:171","msg":"trace[187581590] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16302; }","duration":"184.476046ms","start":"2026-09-12T01:41:30.360938Z","end":"2026-09-12T01:41:30.545414Z","steps":["trace[187581590] 'agreement among raft nodes before linearized reading'  (duration: 184.033846ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:41:30.544945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.140547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-12T01:41:30.544925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.649584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-09-12T01:41:30.545605Z","caller":"traceutil/trace.go:171","msg":"trace[762295158] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16302; }","duration":"183.821652ms","start":"2026-09-12T01:41:30.361762Z","end":"2026-09-12T01:41:30.545584Z","steps":["trace[762295158] 'agreement among raft nodes before linearized reading'  (duration: 183.124067ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:41:30.545713Z","caller":"traceutil/trace.go:171","msg":"trace[1685006044] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16302; }","duration":"181.467273ms","start":"2026-09-12T01:41:30.364227Z","end":"2026-09-12T01:41:30.545694Z","steps":["trace[1685006044] 'agreement among raft nodes before linearized reading'  (duration: 180.41929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:43:26.854991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14572}
{"level":"info","ts":"2026-09-12T01:43:26.937556Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14572,"took":"79.251853ms","hash":2270726838,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":31690752,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-12T01:43:26.93763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2270726838,"revision":14572,"compact-revision":12571}
{"level":"info","ts":"2026-09-12T01:47:18.736263Z","caller":"traceutil/trace.go:171","msg":"trace[1397900703] linearizableReadLoop","detail":"{readStateIndex:19411; appliedIndex:19410; }","duration":"115.889603ms","start":"2026-09-12T01:47:18.620347Z","end":"2026-09-12T01:47:18.736236Z","steps":["trace[1397900703] 'read index received'  (duration: 115.643838ms)","trace[1397900703] 'applied index is now lower than readState.Index'  (duration: 244.985µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:47:18.736568Z","caller":"traceutil/trace.go:171","msg":"trace[1246558922] transaction","detail":"{read_only:false; response_revision:18771; number_of_response:1; }","duration":"121.425831ms","start":"2026-09-12T01:47:18.61513Z","end":"2026-09-12T01:47:18.736556Z","steps":["trace[1246558922] 'process raft request'  (duration: 120.956161ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:18.736878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.487675ms","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-09-12T01:47:18.736917Z","caller":"traceutil/trace.go:171","msg":"trace[66836879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18771; }","duration":"116.605878ms","start":"2026-09-12T01:47:18.620302Z","end":"2026-09-12T01:47:18.736908Z","steps":["trace[66836879] 'agreement among raft nodes before linearized reading'  (duration: 116.428484ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:18.737108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.71849ms","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-09-12T01:47:18.737143Z","caller":"traceutil/trace.go:171","msg":"trace[746774435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18771; }","duration":"116.768391ms","start":"2026-09-12T01:47:18.620364Z","end":"2026-09-12T01:47:18.737133Z","steps":["trace[746774435] 'agreement among raft nodes before linearized reading'  (duration: 116.686379ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.257535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.390241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1818"}
{"level":"info","ts":"2026-09-12T01:47:26.257647Z","caller":"traceutil/trace.go:171","msg":"trace[1123064773] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:18847; }","duration":"219.554054ms","start":"2026-09-12T01:47:26.038059Z","end":"2026-09-12T01:47:26.257614Z","steps":["trace[1123064773] 'range keys from in-memory index tree'  (duration: 219.211988ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.25767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.357642ms","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-09-12T01:47:26.257902Z","caller":"traceutil/trace.go:171","msg":"trace[1469580815] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:18847; }","duration":"196.604697ms","start":"2026-09-12T01:47:26.061263Z","end":"2026-09-12T01:47:26.257868Z","steps":["trace[1469580815] 'range keys from in-memory index tree'  (duration: 196.320171ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:47:26.794957Z","caller":"traceutil/trace.go:171","msg":"trace[1023958658] linearizableReadLoop","detail":"{readStateIndex:19493; appliedIndex:19492; }","duration":"387.785218ms","start":"2026-09-12T01:47:26.407138Z","end":"2026-09-12T01:47:26.794924Z","steps":["trace[1023958658] 'read index received'  (duration: 387.544953ms)","trace[1023958658] 'applied index is now lower than readState.Index'  (duration: 238.795µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:47:26.795423Z","caller":"traceutil/trace.go:171","msg":"trace[309061759] transaction","detail":"{read_only:false; response_revision:18848; number_of_response:1; }","duration":"436.065884ms","start":"2026-09-12T01:47:26.359342Z","end":"2026-09-12T01:47:26.795408Z","steps":["trace[309061759] 'process raft request'  (duration: 435.355168ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.795551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:47:26.359321Z","time spent":"436.147726ms","remote":"127.0.0.1:43710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:18845 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7343 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >"}
{"level":"warn","ts":"2026-09-12T01:47:26.795808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.652157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-crqs7\" ","response":"range_response_count:1 size:9792"}
{"level":"info","ts":"2026-09-12T01:47:26.795922Z","caller":"traceutil/trace.go:171","msg":"trace[1211363596] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-crqs7; range_end:; response_count:1; response_revision:18848; }","duration":"388.84017ms","start":"2026-09-12T01:47:26.407059Z","end":"2026-09-12T01:47:26.795899Z","steps":["trace[1211363596] 'agreement among raft nodes before linearized reading'  (duration: 388.552474ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.795968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:47:26.407026Z","time spent":"388.932403ms","remote":"127.0.0.1:52526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9815,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-crqs7\" "}
{"level":"info","ts":"2026-09-12T01:47:26.831318Z","caller":"traceutil/trace.go:171","msg":"trace[834861924] transaction","detail":"{read_only:false; response_revision:18849; number_of_response:1; }","duration":"226.529261ms","start":"2026-09-12T01:47:26.604765Z","end":"2026-09-12T01:47:26.831295Z","steps":["trace[834861924] 'process raft request'  (duration: 226.124623ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.832076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.502682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T01:47:26.832156Z","caller":"traceutil/trace.go:171","msg":"trace[1028053503] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:18849; }","duration":"314.659385ms","start":"2026-09-12T01:47:26.517474Z","end":"2026-09-12T01:47:26.832134Z","steps":["trace[1028053503] 'agreement among raft nodes before linearized reading'  (duration: 314.521112ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.832143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.64533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-09-12T01:47:26.832212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:47:26.517446Z","time spent":"314.752747ms","remote":"127.0.0.1:52576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "}
{"level":"info","ts":"2026-09-12T01:47:26.832224Z","caller":"traceutil/trace.go:171","msg":"trace[985487716] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18849; }","duration":"302.780112ms","start":"2026-09-12T01:47:26.529424Z","end":"2026-09-12T01:47:26.832204Z","steps":["trace[985487716] 'agreement among raft nodes before linearized reading'  (duration: 302.548838ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:47:26.832265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:47:26.5294Z","time spent":"302.857384ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-09-12T01:48:14.18176Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T01:48:14.189041Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-12T01:48:14.189232Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-12T01:48:26.862395Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17034}
{"level":"info","ts":"2026-09-12T01:48:26.986987Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17034,"took":"121.00826ms","hash":267991217,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":33193984,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-09-12T01:48:26.987054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":267991217,"revision":17034,"compact-revision":14572}
{"level":"info","ts":"2026-09-12T01:53:26.874977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19589}
{"level":"info","ts":"2026-09-12T01:53:26.99717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19589,"took":"118.665132ms","hash":3566989396,"current-db-size-bytes":57393152,"current-db-size":"57 MB","current-db-size-in-use-bytes":30273536,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T01:53:26.997263Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3566989396,"revision":19589,"compact-revision":17034}
{"level":"info","ts":"2026-09-12T01:53:46.993931Z","caller":"traceutil/trace.go:171","msg":"trace[1994120042] linearizableReadLoop","detail":"{readStateIndex:22511; appliedIndex:22510; }","duration":"122.051354ms","start":"2026-09-12T01:53:46.871828Z","end":"2026-09-12T01:53:46.993879Z","steps":["trace[1994120042] 'read index received'  (duration: 102.514638ms)","trace[1994120042] 'applied index is now lower than readState.Index'  (duration: 19.535036ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:53:46.99404Z","caller":"traceutil/trace.go:171","msg":"trace[1992737902] transaction","detail":"{read_only:false; response_revision:21770; number_of_response:1; }","duration":"127.066571ms","start":"2026-09-12T01:53:46.866925Z","end":"2026-09-12T01:53:46.993992Z","steps":["trace[1992737902] 'process raft request'  (duration: 107.393553ms)","trace[1992737902] 'compare'  (duration: 19.31572ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:53:46.994343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.470844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:1137"}
{"level":"info","ts":"2026-09-12T01:53:46.994401Z","caller":"traceutil/trace.go:171","msg":"trace[1265533342] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:21770; }","duration":"122.629757ms","start":"2026-09-12T01:53:46.871756Z","end":"2026-09-12T01:53:46.994385Z","steps":["trace[1265533342] 'agreement among raft nodes before linearized reading'  (duration: 122.363901ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:54:03.164736Z","caller":"traceutil/trace.go:171","msg":"trace[1136933302] transaction","detail":"{read_only:false; response_revision:21852; number_of_response:1; }","duration":"318.720375ms","start":"2026-09-12T01:54:02.84597Z","end":"2026-09-12T01:54:03.16469Z","steps":["trace[1136933302] 'process raft request'  (duration: 318.50279ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:54:03.164978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:54:02.845944Z","time spent":"318.894179ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21842 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-12T01:54:03.36862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.188961ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955150922 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:21843 > 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-09-12T01:54:03.368877Z","caller":"traceutil/trace.go:171","msg":"trace[1965243443] transaction","detail":"{read_only:false; response_revision:21854; number_of_response:1; }","duration":"184.190515ms","start":"2026-09-12T01:54:03.184666Z","end":"2026-09-12T01:54:03.368857Z","steps":["trace[1965243443] 'process raft request'  (duration: 184.058122ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:54:03.369111Z","caller":"traceutil/trace.go:171","msg":"trace[772284234] linearizableReadLoop","detail":"{readStateIndex:22597; appliedIndex:22596; }","duration":"186.874822ms","start":"2026-09-12T01:54:03.182221Z","end":"2026-09-12T01:54:03.369096Z","steps":["trace[772284234] 'read index received'  (duration: 61.091958ms)","trace[772284234] 'applied index is now lower than readState.Index'  (duration: 125.781664ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:54:03.369078Z","caller":"traceutil/trace.go:171","msg":"trace[1386628665] transaction","detail":"{read_only:false; response_revision:21853; number_of_response:1; }","duration":"198.439698ms","start":"2026-09-12T01:54:03.170567Z","end":"2026-09-12T01:54:03.369007Z","steps":["trace[1386628665] 'process raft request'  (duration: 72.769007ms)","trace[1386628665] 'compare'  (duration: 124.68038ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T01:54:03.36949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.246451ms","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-09-12T01:54:03.369592Z","caller":"traceutil/trace.go:171","msg":"trace[1600396419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21854; }","duration":"187.391273ms","start":"2026-09-12T01:54:03.182178Z","end":"2026-09-12T01:54:03.369569Z","steps":["trace[1600396419] 'agreement among raft nodes before linearized reading'  (duration: 186.982035ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:54:03.369492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.518409ms","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-09-12T01:54:03.369977Z","caller":"traceutil/trace.go:171","msg":"trace[1850246629] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21854; }","duration":"182.014109ms","start":"2026-09-12T01:54:03.18794Z","end":"2026-09-12T01:54:03.369954Z","steps":["trace[1850246629] 'agreement among raft nodes before linearized reading'  (duration: 181.353455ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:54:03.556417Z","caller":"traceutil/trace.go:171","msg":"trace[887252465] transaction","detail":"{read_only:false; response_revision:21857; number_of_response:1; }","duration":"180.261722ms","start":"2026-09-12T01:54:03.376114Z","end":"2026-09-12T01:54:03.556375Z","steps":["trace[887252465] 'process raft request'  (duration: 180.101489ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:54:03.556426Z","caller":"traceutil/trace.go:171","msg":"trace[553619546] transaction","detail":"{read_only:false; response_revision:21856; number_of_response:1; }","duration":"180.282394ms","start":"2026-09-12T01:54:03.376099Z","end":"2026-09-12T01:54:03.556382Z","steps":["trace[553619546] 'process raft request'  (duration: 161.617056ms)","trace[553619546] 'compare'  (duration: 18.071354ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:54:03.860994Z","caller":"traceutil/trace.go:171","msg":"trace[508276949] transaction","detail":"{read_only:false; response_revision:21858; number_of_response:1; }","duration":"249.413802ms","start":"2026-09-12T01:54:03.611531Z","end":"2026-09-12T01:54:03.860945Z","steps":["trace[508276949] 'process raft request'  (duration: 249.142796ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T01:54:04.05132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.438979ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955150934 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:21849 > 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-09-12T01:54:04.051483Z","caller":"traceutil/trace.go:171","msg":"trace[922481050] transaction","detail":"{read_only:false; response_revision:21859; number_of_response:1; }","duration":"185.473443ms","start":"2026-09-12T01:54:03.865979Z","end":"2026-09-12T01:54:04.051453Z","steps":["trace[922481050] 'process raft request'  (duration: 33.755418ms)","trace[922481050] 'compare'  (duration: 151.279406ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T01:58:22.642584Z","caller":"traceutil/trace.go:171","msg":"trace[1850625071] transaction","detail":"{read_only:false; response_revision:24442; number_of_response:1; }","duration":"233.066624ms","start":"2026-09-12T01:58:22.409491Z","end":"2026-09-12T01:58:22.642558Z","steps":["trace[1850625071] 'process raft request'  (duration: 232.89023ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T01:58:26.881586Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21667}
{"level":"info","ts":"2026-09-12T01:58:27.001052Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21667,"took":"113.916612ms","hash":868386995,"current-db-size-bytes":59129856,"current-db-size":"59 MB","current-db-size-in-use-bytes":41955328,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-09-12T01:58:27.001124Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":868386995,"revision":21667,"compact-revision":19589}
{"level":"info","ts":"2026-09-12T01:59:54.252003Z","caller":"traceutil/trace.go:171","msg":"trace[2038836657] transaction","detail":"{read_only:false; response_revision:25399; number_of_response:1; }","duration":"131.103019ms","start":"2026-09-12T01:59:54.120863Z","end":"2026-09-12T01:59:54.251966Z","steps":["trace[2038836657] 'process raft request'  (duration: 130.918075ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:00:31.273285Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006836.wal"}
{"level":"info","ts":"2026-09-12T02:02:08.644875Z","caller":"traceutil/trace.go:171","msg":"trace[1080940152] transaction","detail":"{read_only:false; response_revision:26743; number_of_response:1; }","duration":"118.146963ms","start":"2026-09-12T02:02:08.526698Z","end":"2026-09-12T02:02:08.644845Z","steps":["trace[1080940152] 'process raft request'  (duration: 117.955329ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:08.966485Z","caller":"traceutil/trace.go:171","msg":"trace[560943485] linearizableReadLoop","detail":"{readStateIndex:27618; appliedIndex:27617; }","duration":"171.16739ms","start":"2026-09-12T02:02:08.795288Z","end":"2026-09-12T02:02:08.966455Z","steps":["trace[560943485] 'read index received'  (duration: 171.014187ms)","trace[560943485] 'applied index is now lower than readState.Index'  (duration: 151.993µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:08.966536Z","caller":"traceutil/trace.go:171","msg":"trace[2041301087] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"203.057429ms","start":"2026-09-12T02:02:08.76345Z","end":"2026-09-12T02:02:08.966508Z","steps":["trace[2041301087] 'process raft request'  (duration: 202.845835ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:08.966708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.339824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:08.966786Z","caller":"traceutil/trace.go:171","msg":"trace[26724058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26744; }","duration":"171.551209ms","start":"2026-09-12T02:02:08.7952Z","end":"2026-09-12T02:02:08.966751Z","steps":["trace[26724058] 'agreement among raft nodes before linearized reading'  (duration: 171.383005ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:08.981298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.061793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:08.981348Z","caller":"traceutil/trace.go:171","msg":"trace[2060095267] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26745; }","duration":"120.120564ms","start":"2026-09-12T02:02:08.861214Z","end":"2026-09-12T02:02:08.981335Z","steps":["trace[2060095267] 'agreement among raft nodes before linearized reading'  (duration: 120.024682ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:08.981327Z","caller":"traceutil/trace.go:171","msg":"trace[864502434] transaction","detail":"{read_only:false; response_revision:26745; number_of_response:1; }","duration":"127.252056ms","start":"2026-09-12T02:02:08.854034Z","end":"2026-09-12T02:02:08.981286Z","steps":["trace[864502434] 'process raft request'  (duration: 127.028442ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:14.437832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.433536ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955163879 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26769 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:02:14.438288Z","caller":"traceutil/trace.go:171","msg":"trace[1952446097] transaction","detail":"{read_only:false; response_revision:26784; number_of_response:1; }","duration":"260.758535ms","start":"2026-09-12T02:02:14.177498Z","end":"2026-09-12T02:02:14.438257Z","steps":["trace[1952446097] 'process raft request'  (duration: 119.788518ms)","trace[1952446097] 'compare'  (duration: 139.968567ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:14.43839Z","caller":"traceutil/trace.go:171","msg":"trace[722431959] linearizableReadLoop","detail":"{readStateIndex:27659; appliedIndex:27658; }","duration":"256.406653ms","start":"2026-09-12T02:02:14.181945Z","end":"2026-09-12T02:02:14.438351Z","steps":["trace[722431959] 'read index received'  (duration: 115.356824ms)","trace[722431959] 'applied index is now lower than readState.Index'  (duration: 141.044449ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:14.438719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.750911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T02:02:14.438854Z","caller":"traceutil/trace.go:171","msg":"trace[1209945988] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26784; }","duration":"256.939935ms","start":"2026-09-12T02:02:14.181889Z","end":"2026-09-12T02:02:14.438829Z","steps":["trace[1209945988] 'agreement among raft nodes before linearized reading'  (duration: 256.551917ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:14.439133Z","caller":"traceutil/trace.go:171","msg":"trace[365995782] transaction","detail":"{read_only:false; response_revision:26785; number_of_response:1; }","duration":"147.718781ms","start":"2026-09-12T02:02:14.291357Z","end":"2026-09-12T02:02:14.439076Z","steps":["trace[365995782] 'process raft request'  (duration: 146.578337ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:14.439637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.823693ms","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-09-12T02:02:14.439843Z","caller":"traceutil/trace.go:171","msg":"trace[286786302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26785; }","duration":"116.076629ms","start":"2026-09-12T02:02:14.323749Z","end":"2026-09-12T02:02:14.439825Z","steps":["trace[286786302] 'agreement among raft nodes before linearized reading'  (duration: 115.577288ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:14.439222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.70093ms","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-09-12T02:02:14.440871Z","caller":"traceutil/trace.go:171","msg":"trace[981202724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26785; }","duration":"117.390667ms","start":"2026-09-12T02:02:14.323462Z","end":"2026-09-12T02:02:14.440852Z","steps":["trace[981202724] 'agreement among raft nodes before linearized reading'  (duration: 115.587858ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:14.738498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.172501ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955163885 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26772 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:02:14.738616Z","caller":"traceutil/trace.go:171","msg":"trace[2108400604] linearizableReadLoop","detail":"{readStateIndex:27662; appliedIndex:27660; }","duration":"285.360859ms","start":"2026-09-12T02:02:14.453234Z","end":"2026-09-12T02:02:14.738595Z","steps":["trace[2108400604] 'read index received'  (duration: 5.878205ms)","trace[2108400604] 'applied index is now lower than readState.Index'  (duration: 279.481064ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:14.738694Z","caller":"traceutil/trace.go:171","msg":"trace[897567896] transaction","detail":"{read_only:false; response_revision:26787; number_of_response:1; }","duration":"287.529434ms","start":"2026-09-12T02:02:14.451123Z","end":"2026-09-12T02:02:14.738653Z","steps":["trace[897567896] 'process raft request'  (duration: 187.094568ms)","trace[897567896] 'compare'  (duration: 100.009727ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:14.738868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.622165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-09-12T02:02:14.738921Z","caller":"traceutil/trace.go:171","msg":"trace[1962512734] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26787; }","duration":"285.691807ms","start":"2026-09-12T02:02:14.453212Z","end":"2026-09-12T02:02:14.738904Z","steps":["trace[1962512734] 'agreement among raft nodes before linearized reading'  (duration: 285.501473ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:15.155403Z","caller":"traceutil/trace.go:171","msg":"trace[267017175] transaction","detail":"{read_only:false; response_revision:26788; number_of_response:1; }","duration":"158.188194ms","start":"2026-09-12T02:02:14.99719Z","end":"2026-09-12T02:02:15.155378Z","steps":["trace[267017175] 'process raft request'  (duration: 158.02886ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:15.32274Z","caller":"traceutil/trace.go:171","msg":"trace[1585070317] transaction","detail":"{read_only:false; response_revision:26789; number_of_response:1; }","duration":"295.69059ms","start":"2026-09-12T02:02:15.027025Z","end":"2026-09-12T02:02:15.322715Z","steps":["trace[1585070317] 'process raft request'  (duration: 224.415843ms)","trace[1585070317] 'compare'  (duration: 70.896979ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:15.322825Z","caller":"traceutil/trace.go:171","msg":"trace[1543431704] linearizableReadLoop","detail":"{readStateIndex:27665; appliedIndex:27662; }","duration":"176.78245ms","start":"2026-09-12T02:02:15.146014Z","end":"2026-09-12T02:02:15.322797Z","steps":["trace[1543431704] 'read index received'  (duration: 9.234226ms)","trace[1543431704] 'applied index is now lower than readState.Index'  (duration: 167.547194ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:15.322995Z","caller":"traceutil/trace.go:171","msg":"trace[212311205] transaction","detail":"{read_only:false; response_revision:26790; number_of_response:1; }","duration":"195.395256ms","start":"2026-09-12T02:02:15.127592Z","end":"2026-09-12T02:02:15.322988Z","steps":["trace[212311205] 'process raft request'  (duration: 194.954987ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:15.323112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.079496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"}
{"level":"info","ts":"2026-09-12T02:02:15.323192Z","caller":"traceutil/trace.go:171","msg":"trace[1307696981] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:26790; }","duration":"177.201539ms","start":"2026-09-12T02:02:15.145966Z","end":"2026-09-12T02:02:15.323167Z","steps":["trace[1307696981] 'agreement among raft nodes before linearized reading'  (duration: 176.919173ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:15.592064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.429552ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955163893 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26776 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:02:15.592292Z","caller":"traceutil/trace.go:171","msg":"trace[1266891632] linearizableReadLoop","detail":"{readStateIndex:27667; appliedIndex:27665; }","duration":"266.416967ms","start":"2026-09-12T02:02:15.325845Z","end":"2026-09-12T02:02:15.592262Z","steps":["trace[1266891632] 'read index received'  (duration: 105.632437ms)","trace[1266891632] 'applied index is now lower than readState.Index'  (duration: 160.78361ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:15.592412Z","caller":"traceutil/trace.go:171","msg":"trace[341285266] transaction","detail":"{read_only:false; response_revision:26792; number_of_response:1; }","duration":"401.386156ms","start":"2026-09-12T02:02:15.191015Z","end":"2026-09-12T02:02:15.592401Z","steps":["trace[341285266] 'process raft request'  (duration: 401.162192ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:15.592441Z","caller":"traceutil/trace.go:171","msg":"trace[1380263691] transaction","detail":"{read_only:false; response_revision:26791; number_of_response:1; }","duration":"421.355011ms","start":"2026-09-12T02:02:15.171051Z","end":"2026-09-12T02:02:15.592406Z","steps":["trace[1380263691] 'process raft request'  (duration: 260.485549ms)","trace[1380263691] 'compare'  (duration: 160.239538ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:15.592474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:15.190993Z","time spent":"401.442857ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:26713 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-09-12T02:02:15.59253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:15.171024Z","time spent":"421.458293ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26776 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-12T02:02:15.592867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.003618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-366ba92c-7ab2-4671-850d-6c51b61afb46\" ","response":"range_response_count:1 size:1436"}
{"level":"info","ts":"2026-09-12T02:02:15.592948Z","caller":"traceutil/trace.go:171","msg":"trace[297909396] range","detail":"{range_begin:/registry/persistentvolumes/pvc-366ba92c-7ab2-4671-850d-6c51b61afb46; range_end:; response_count:1; response_revision:26792; }","duration":"267.1198ms","start":"2026-09-12T02:02:15.325803Z","end":"2026-09-12T02:02:15.592923Z","steps":["trace[297909396] 'agreement among raft nodes before linearized reading'  (duration: 266.854905ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:16.513392Z","caller":"traceutil/trace.go:171","msg":"trace[2054931278] linearizableReadLoop","detail":"{readStateIndex:27674; appliedIndex:27673; }","duration":"180.838266ms","start":"2026-09-12T02:02:16.33253Z","end":"2026-09-12T02:02:16.513368Z","steps":["trace[2054931278] 'read index received'  (duration: 180.733244ms)","trace[2054931278] 'applied index is now lower than readState.Index'  (duration: 103.832µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:16.513554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.99953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:16.513608Z","caller":"traceutil/trace.go:171","msg":"trace[1845024817] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:26798; }","duration":"181.095812ms","start":"2026-09-12T02:02:16.332485Z","end":"2026-09-12T02:02:16.513581Z","steps":["trace[1845024817] 'agreement among raft nodes before linearized reading'  (duration: 180.99579ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:16.513664Z","caller":"traceutil/trace.go:171","msg":"trace[1188724562] transaction","detail":"{read_only:false; response_revision:26798; number_of_response:1; }","duration":"329.783085ms","start":"2026-09-12T02:02:16.183707Z","end":"2026-09-12T02:02:16.51349Z","steps":["trace[1188724562] 'process raft request'  (duration: 329.513919ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:16.513863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:16.183676Z","time spent":"330.07171ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26783 > 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-09-12T02:02:16.755352Z","caller":"traceutil/trace.go:171","msg":"trace[1857740433] linearizableReadLoop","detail":"{readStateIndex:27675; appliedIndex:27674; }","duration":"241.866904ms","start":"2026-09-12T02:02:16.513456Z","end":"2026-09-12T02:02:16.755323Z","steps":["trace[1857740433] 'read index received'  (duration: 148.425957ms)","trace[1857740433] 'applied index is now lower than readState.Index'  (duration: 93.439507ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:16.755485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.681027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T02:02:16.755539Z","caller":"traceutil/trace.go:171","msg":"trace[1290412053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:26799; }","duration":"278.807409ms","start":"2026-09-12T02:02:16.476719Z","end":"2026-09-12T02:02:16.755527Z","steps":["trace[1290412053] 'agreement among raft nodes before linearized reading'  (duration: 278.688477ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:16.75579Z","caller":"traceutil/trace.go:171","msg":"trace[303178648] transaction","detail":"{read_only:false; response_revision:26799; number_of_response:1; }","duration":"309.563474ms","start":"2026-09-12T02:02:16.446213Z","end":"2026-09-12T02:02:16.755777Z","steps":["trace[303178648] 'process raft request'  (duration: 215.755319ms)","trace[303178648] 'compare'  (duration: 93.13161ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:16.755953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:16.446192Z","time spent":"309.720377ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26785 > 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-09-12T02:02:16.756216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.336805ms","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-09-12T02:02:16.756315Z","caller":"traceutil/trace.go:171","msg":"trace[335860455] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26799; }","duration":"314.537049ms","start":"2026-09-12T02:02:16.441752Z","end":"2026-09-12T02:02:16.756289Z","steps":["trace[335860455] 'agreement among raft nodes before linearized reading'  (duration: 314.126531ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:16.756384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:16.441729Z","time spent":"314.640532ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-12T02:02:16.756434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.241546ms","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-09-12T02:02:16.756471Z","caller":"traceutil/trace.go:171","msg":"trace[726845784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26799; }","duration":"293.306919ms","start":"2026-09-12T02:02:16.463155Z","end":"2026-09-12T02:02:16.756462Z","steps":["trace[726845784] 'agreement among raft nodes before linearized reading'  (duration: 292.303697ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:17.301555Z","caller":"traceutil/trace.go:171","msg":"trace[1535821177] transaction","detail":"{read_only:false; response_revision:26803; number_of_response:1; }","duration":"141.96203ms","start":"2026-09-12T02:02:17.159567Z","end":"2026-09-12T02:02:17.301529Z","steps":["trace[1535821177] 'process raft request'  (duration: 141.801786ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:17.544277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.106131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T02:02:17.544353Z","caller":"traceutil/trace.go:171","msg":"trace[34171856] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:26804; }","duration":"172.262934ms","start":"2026-09-12T02:02:17.372075Z","end":"2026-09-12T02:02:17.544338Z","steps":["trace[34171856] 'count revisions from in-memory index tree'  (duration: 171.990779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:17.81764Z","caller":"traceutil/trace.go:171","msg":"trace[1095872114] transaction","detail":"{read_only:false; response_revision:26806; number_of_response:1; }","duration":"112.594595ms","start":"2026-09-12T02:02:17.70502Z","end":"2026-09-12T02:02:17.817614Z","steps":["trace[1095872114] 'process raft request'  (duration: 110.325666ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:17.889706Z","caller":"traceutil/trace.go:171","msg":"trace[1654751734] transaction","detail":"{read_only:false; response_revision:26808; number_of_response:1; }","duration":"183.866041ms","start":"2026-09-12T02:02:17.705816Z","end":"2026-09-12T02:02:17.889682Z","steps":["trace[1654751734] 'process raft request'  (duration: 183.790059ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:17.889726Z","caller":"traceutil/trace.go:171","msg":"trace[521302470] transaction","detail":"{read_only:false; response_revision:26807; number_of_response:1; }","duration":"183.879141ms","start":"2026-09-12T02:02:17.705805Z","end":"2026-09-12T02:02:17.889685Z","steps":["trace[521302470] 'process raft request'  (duration: 183.661196ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:17.889972Z","caller":"traceutil/trace.go:171","msg":"trace[1344533702] linearizableReadLoop","detail":"{readStateIndex:27684; appliedIndex:27681; }","duration":"178.628909ms","start":"2026-09-12T02:02:17.711299Z","end":"2026-09-12T02:02:17.889928Z","steps":["trace[1344533702] 'read index received'  (duration: 104.013112ms)","trace[1344533702] 'applied index is now lower than readState.Index'  (duration: 74.612847ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:17.890134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.807514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:17.890176Z","caller":"traceutil/trace.go:171","msg":"trace[941260440] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:26809; }","duration":"178.900705ms","start":"2026-09-12T02:02:17.711261Z","end":"2026-09-12T02:02:17.890162Z","steps":["trace[941260440] 'agreement among raft nodes before linearized reading'  (duration: 178.812013ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:17.890217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.058517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:17.890264Z","caller":"traceutil/trace.go:171","msg":"trace[994200150] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities0; response_count:0; response_revision:26809; }","duration":"123.16161ms","start":"2026-09-12T02:02:17.767086Z","end":"2026-09-12T02:02:17.890248Z","steps":["trace[994200150] 'agreement among raft nodes before linearized reading'  (duration: 123.050067ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:18.06216Z","caller":"traceutil/trace.go:171","msg":"trace[224876240] transaction","detail":"{read_only:false; response_revision:26810; number_of_response:1; }","duration":"143.235707ms","start":"2026-09-12T02:02:17.918901Z","end":"2026-09-12T02:02:18.062137Z","steps":["trace[224876240] 'process raft request'  (duration: 130.350223ms)","trace[224876240] 'compare'  (duration: 12.647969ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:18.062464Z","caller":"traceutil/trace.go:171","msg":"trace[552097320] transaction","detail":"{read_only:false; response_revision:26811; number_of_response:1; }","duration":"142.556942ms","start":"2026-09-12T02:02:17.919874Z","end":"2026-09-12T02:02:18.062431Z","steps":["trace[552097320] 'process raft request'  (duration: 142.206515ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:18.908621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.038315ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955163938 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26799 > 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-09-12T02:02:18.908743Z","caller":"traceutil/trace.go:171","msg":"trace[521632822] linearizableReadLoop","detail":"{readStateIndex:27689; appliedIndex:27688; }","duration":"139.321113ms","start":"2026-09-12T02:02:18.769396Z","end":"2026-09-12T02:02:18.908717Z","steps":["trace[521632822] 'read index received'  (duration: 10.045674ms)","trace[521632822] 'applied index is now lower than readState.Index'  (duration: 129.273389ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:18.908875Z","caller":"traceutil/trace.go:171","msg":"trace[2101748761] transaction","detail":"{read_only:false; response_revision:26813; number_of_response:1; }","duration":"147.510087ms","start":"2026-09-12T02:02:18.761346Z","end":"2026-09-12T02:02:18.908856Z","steps":["trace[2101748761] 'process raft request'  (duration: 18.154656ms)","trace[2101748761] 'compare'  (duration: 128.691287ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:18.90936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.952457ms","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-09-12T02:02:18.909464Z","caller":"traceutil/trace.go:171","msg":"trace[1692579637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26813; }","duration":"140.1014ms","start":"2026-09-12T02:02:18.769345Z","end":"2026-09-12T02:02:18.909446Z","steps":["trace[1692579637] 'agreement among raft nodes before linearized reading'  (duration: 139.513077ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:19.072877Z","caller":"traceutil/trace.go:171","msg":"trace[839792748] linearizableReadLoop","detail":"{readStateIndex:27690; appliedIndex:27689; }","duration":"164.038179ms","start":"2026-09-12T02:02:18.908812Z","end":"2026-09-12T02:02:19.07285Z","steps":["trace[839792748] 'read index received'  (duration: 163.821634ms)","trace[839792748] 'applied index is now lower than readState.Index'  (duration: 215.135µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:19.072996Z","caller":"traceutil/trace.go:171","msg":"trace[463872494] transaction","detail":"{read_only:false; response_revision:26814; number_of_response:1; }","duration":"223.418211ms","start":"2026-09-12T02:02:18.849543Z","end":"2026-09-12T02:02:19.072961Z","steps":["trace[463872494] 'process raft request'  (duration: 223.115635ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:19.073333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.932842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:19.07346Z","caller":"traceutil/trace.go:171","msg":"trace[1831545501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26814; }","duration":"279.126627ms","start":"2026-09-12T02:02:18.794314Z","end":"2026-09-12T02:02:19.073441Z","steps":["trace[1831545501] 'agreement among raft nodes before linearized reading'  (duration: 278.954523ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:19.073583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.196836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-09-12T02:02:19.073637Z","caller":"traceutil/trace.go:171","msg":"trace[333703602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26814; }","duration":"293.271508ms","start":"2026-09-12T02:02:18.780353Z","end":"2026-09-12T02:02:19.073624Z","steps":["trace[333703602] 'agreement among raft nodes before linearized reading'  (duration: 293.096414ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:19.07385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.406501ms","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-09-12T02:02:19.073906Z","caller":"traceutil/trace.go:171","msg":"trace[1925076932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26814; }","duration":"294.089544ms","start":"2026-09-12T02:02:18.779803Z","end":"2026-09-12T02:02:19.073892Z","steps":["trace[1925076932] 'agreement among raft nodes before linearized reading'  (duration: 293.140454ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:19.08424Z","caller":"traceutil/trace.go:171","msg":"trace[516874413] transaction","detail":"{read_only:false; response_revision:26815; number_of_response:1; }","duration":"170.591137ms","start":"2026-09-12T02:02:18.91363Z","end":"2026-09-12T02:02:19.084221Z","steps":["trace[516874413] 'process raft request'  (duration: 170.350532ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:19.436597Z","caller":"traceutil/trace.go:171","msg":"trace[452124272] transaction","detail":"{read_only:false; response_revision:26818; number_of_response:1; }","duration":"128.748668ms","start":"2026-09-12T02:02:19.307801Z","end":"2026-09-12T02:02:19.43655Z","steps":["trace[452124272] 'process raft request'  (duration: 37.625811ms)","trace[452124272] 'compare'  (duration: 90.459023ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:19.636467Z","caller":"traceutil/trace.go:171","msg":"trace[871939799] transaction","detail":"{read_only:false; response_revision:26819; number_of_response:1; }","duration":"194.767113ms","start":"2026-09-12T02:02:19.441672Z","end":"2026-09-12T02:02:19.636439Z","steps":["trace[871939799] 'process raft request'  (duration: 194.60472ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:20.018246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.246951ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955163952 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26806 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:02:20.018397Z","caller":"traceutil/trace.go:171","msg":"trace[945522555] transaction","detail":"{read_only:false; response_revision:26821; number_of_response:1; }","duration":"194.638531ms","start":"2026-09-12T02:02:19.823721Z","end":"2026-09-12T02:02:20.01836Z","steps":["trace[945522555] 'process raft request'  (duration: 72.201236ms)","trace[945522555] 'compare'  (duration: 121.880813ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:20.018449Z","caller":"traceutil/trace.go:171","msg":"trace[1546099514] transaction","detail":"{read_only:false; response_revision:26822; number_of_response:1; }","duration":"122.315112ms","start":"2026-09-12T02:02:19.896118Z","end":"2026-09-12T02:02:20.018433Z","steps":["trace[1546099514] 'process raft request'  (duration: 122.227951ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:20.018508Z","caller":"traceutil/trace.go:171","msg":"trace[1679279656] linearizableReadLoop","detail":"{readStateIndex:27697; appliedIndex:27696; }","duration":"183.786049ms","start":"2026-09-12T02:02:19.83469Z","end":"2026-09-12T02:02:20.018476Z","steps":["trace[1679279656] 'read index received'  (duration: 61.154751ms)","trace[1679279656] 'applied index is now lower than readState.Index'  (duration: 122.629378ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:20.018696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.983523ms","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-09-12T02:02:20.018778Z","caller":"traceutil/trace.go:171","msg":"trace[997593413] 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:26822; }","duration":"184.059295ms","start":"2026-09-12T02:02:19.83468Z","end":"2026-09-12T02:02:20.018739Z","steps":["trace[997593413] 'agreement among raft nodes before linearized reading'  (duration: 183.907942ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:20.0188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.429234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T02:02:20.018877Z","caller":"traceutil/trace.go:171","msg":"trace[1041160475] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26820; }","duration":"271.547175ms","start":"2026-09-12T02:02:19.747311Z","end":"2026-09-12T02:02:20.018858Z","steps":["trace[1041160475] 'range keys from in-memory index tree'  (duration: 270.638597ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:20.05047Z","caller":"traceutil/trace.go:171","msg":"trace[935683687] transaction","detail":"{read_only:false; response_revision:26823; number_of_response:1; }","duration":"153.401892ms","start":"2026-09-12T02:02:19.897039Z","end":"2026-09-12T02:02:20.050441Z","steps":["trace[935683687] 'process raft request'  (duration: 153.050734ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:20.189115Z","caller":"traceutil/trace.go:171","msg":"trace[226628317] transaction","detail":"{read_only:false; response_revision:26824; number_of_response:1; }","duration":"121.058654ms","start":"2026-09-12T02:02:20.06803Z","end":"2026-09-12T02:02:20.189089Z","steps":["trace[226628317] 'process raft request'  (duration: 95.820597ms)","trace[226628317] 'compare'  (duration: 25.104144ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:20.193535Z","caller":"traceutil/trace.go:171","msg":"trace[1654470654] transaction","detail":"{read_only:false; response_revision:26825; number_of_response:1; }","duration":"124.316214ms","start":"2026-09-12T02:02:20.069162Z","end":"2026-09-12T02:02:20.193479Z","steps":["trace[1654470654] 'process raft request'  (duration: 124.078739ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.574362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.26245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:30.574429Z","caller":"traceutil/trace.go:171","msg":"trace[621416660] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:26902; }","duration":"280.373833ms","start":"2026-09-12T02:02:30.294039Z","end":"2026-09-12T02:02:30.574413Z","steps":["trace[621416660] 'count revisions from in-memory index tree'  (duration: 280.168719ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.574603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.723537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T02:02:30.574647Z","caller":"traceutil/trace.go:171","msg":"trace[128341668] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26902; }","duration":"245.773408ms","start":"2026-09-12T02:02:30.328866Z","end":"2026-09-12T02:02:30.574639Z","steps":["trace[128341668] 'range keys from in-memory index tree'  (duration: 245.594114ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.574834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.716916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-09-12T02:02:30.574881Z","caller":"traceutil/trace.go:171","msg":"trace[1356007451] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26902; }","duration":"238.808718ms","start":"2026-09-12T02:02:30.336057Z","end":"2026-09-12T02:02:30.574866Z","steps":["trace[1356007451] 'range keys from in-memory index tree'  (duration: 238.335179ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:30.682108Z","caller":"traceutil/trace.go:171","msg":"trace[902553929] linearizableReadLoop","detail":"{readStateIndex:27782; appliedIndex:27781; }","duration":"326.754779ms","start":"2026-09-12T02:02:30.35533Z","end":"2026-09-12T02:02:30.682084Z","steps":["trace[902553929] 'read index received'  (duration: 326.545264ms)","trace[902553929] 'applied index is now lower than readState.Index'  (duration: 208.645µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:30.682238Z","caller":"traceutil/trace.go:171","msg":"trace[1539014941] transaction","detail":"{read_only:false; response_revision:26903; number_of_response:1; }","duration":"335.22505ms","start":"2026-09-12T02:02:30.346963Z","end":"2026-09-12T02:02:30.682188Z","steps":["trace[1539014941] 'process raft request'  (duration: 334.968833ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.682323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.299299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:30.682361Z","caller":"traceutil/trace.go:171","msg":"trace[1600798312] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:26903; }","duration":"302.33199ms","start":"2026-09-12T02:02:30.380016Z","end":"2026-09-12T02:02:30.682348Z","steps":["trace[1600798312] 'agreement among raft nodes before linearized reading'  (duration: 302.285489ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.682408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:30.379977Z","time spent":"302.416872ms","remote":"127.0.0.1:51552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true "}
{"level":"warn","ts":"2026-09-12T02:02:30.682425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:30.346942Z","time spent":"335.382143ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:26859 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-09-12T02:02:30.682273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.906052ms","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-09-12T02:02:30.682588Z","caller":"traceutil/trace.go:171","msg":"trace[1129086449] 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:26903; }","duration":"327.27ms","start":"2026-09-12T02:02:30.355294Z","end":"2026-09-12T02:02:30.682564Z","steps":["trace[1129086449] 'agreement among raft nodes before linearized reading'  (duration: 326.912323ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.682694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:30.355278Z","time spent":"327.387342ms","remote":"127.0.0.1:52654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":29,"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-09-12T02:02:30.682807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.84479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T02:02:30.682853Z","caller":"traceutil/trace.go:171","msg":"trace[331243196] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26903; }","duration":"104.918722ms","start":"2026-09-12T02:02:30.577922Z","end":"2026-09-12T02:02:30.68284Z","steps":["trace[331243196] 'agreement among raft nodes before linearized reading'  (duration: 104.759369ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:30.682875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.044505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.111\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-09-12T02:02:30.682928Z","caller":"traceutil/trace.go:171","msg":"trace[2036482088] range","detail":"{range_begin:/registry/masterleases/162.253.55.111; range_end:; response_count:1; response_revision:26903; }","duration":"231.141147ms","start":"2026-09-12T02:02:30.451773Z","end":"2026-09-12T02:02:30.682914Z","steps":["trace[2036482088] 'agreement among raft nodes before linearized reading'  (duration: 230.955053ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.190663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.510695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:31.190746Z","caller":"traceutil/trace.go:171","msg":"trace[2139564377] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26905; }","duration":"351.666599ms","start":"2026-09-12T02:02:30.839059Z","end":"2026-09-12T02:02:31.190725Z","steps":["trace[2139564377] 'range keys from in-memory index tree'  (duration: 351.432614ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.190813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:30.839041Z","time spent":"351.75622ms","remote":"127.0.0.1:52786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-09-12T02:02:31.19109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.760442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-09-12T02:02:31.19114Z","caller":"traceutil/trace.go:171","msg":"trace[693746841] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:26905; }","duration":"375.856954ms","start":"2026-09-12T02:02:30.815263Z","end":"2026-09-12T02:02:31.19112Z","steps":["trace[693746841] 'count revisions from in-memory index tree'  (duration: 375.66517ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.191176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:30.815239Z","time spent":"375.923295ms","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":141,"response size":32,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"info","ts":"2026-09-12T02:02:31.193074Z","caller":"traceutil/trace.go:171","msg":"trace[1113673831] linearizableReadLoop","detail":"{readStateIndex:27786; appliedIndex:27785; }","duration":"165.365106ms","start":"2026-09-12T02:02:31.027682Z","end":"2026-09-12T02:02:31.193048Z","steps":["trace[1113673831] 'read index received'  (duration: 165.145192ms)","trace[1113673831] 'applied index is now lower than readState.Index'  (duration: 218.874µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:31.193189Z","caller":"traceutil/trace.go:171","msg":"trace[80161003] transaction","detail":"{read_only:false; response_revision:26906; number_of_response:1; }","duration":"248.194589ms","start":"2026-09-12T02:02:30.944985Z","end":"2026-09-12T02:02:31.193179Z","steps":["trace[80161003] 'process raft request'  (duration: 247.900523ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.193497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.794506ms","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":"info","ts":"2026-09-12T02:02:31.193563Z","caller":"traceutil/trace.go:171","msg":"trace[1476049452] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:26906; }","duration":"165.912638ms","start":"2026-09-12T02:02:31.027634Z","end":"2026-09-12T02:02:31.193546Z","steps":["trace[1476049452] 'agreement among raft nodes before linearized reading'  (duration: 165.814036ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:31.528689Z","caller":"traceutil/trace.go:171","msg":"trace[1102494950] transaction","detail":"{read_only:false; response_revision:26908; number_of_response:1; }","duration":"315.94232ms","start":"2026-09-12T02:02:31.212705Z","end":"2026-09-12T02:02:31.528647Z","steps":["trace[1102494950] 'process raft request'  (duration: 278.164997ms)","trace[1102494950] 'compare'  (duration: 37.539848ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:31.52889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:31.212675Z","time spent":"316.107573ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26890 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-09-12T02:02:31.817918Z","caller":"traceutil/trace.go:171","msg":"trace[1745980411] linearizableReadLoop","detail":"{readStateIndex:27789; appliedIndex:27787; }","duration":"596.240561ms","start":"2026-09-12T02:02:31.22165Z","end":"2026-09-12T02:02:31.817891Z","steps":["trace[1745980411] 'read index received'  (duration: 269.183465ms)","trace[1745980411] 'applied index is now lower than readState.Index'  (duration: 327.056216ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:31.817953Z","caller":"traceutil/trace.go:171","msg":"trace[826445513] transaction","detail":"{read_only:false; response_revision:26910; number_of_response:1; }","duration":"338.112512ms","start":"2026-09-12T02:02:31.479811Z","end":"2026-09-12T02:02:31.817924Z","steps":["trace[826445513] 'process raft request'  (duration: 337.974489ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:31.818158Z","caller":"traceutil/trace.go:171","msg":"trace[442099127] transaction","detail":"{read_only:false; response_revision:26909; number_of_response:1; }","duration":"605.260543ms","start":"2026-09-12T02:02:31.212854Z","end":"2026-09-12T02:02:31.818114Z","steps":["trace[442099127] 'process raft request'  (duration: 593.206907ms)","trace[442099127] 'compare'  (duration: 11.380211ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:31.81831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:31.479782Z","time spent":"338.373997ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26895 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-12T02:02:31.818358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:31.21282Z","time spent":"605.426906ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26889 > 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-09-12T02:02:31.818361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.678471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-09-12T02:02:31.818507Z","caller":"traceutil/trace.go:171","msg":"trace[814033528] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26910; }","duration":"596.863534ms","start":"2026-09-12T02:02:31.221617Z","end":"2026-09-12T02:02:31.818481Z","steps":["trace[814033528] 'agreement among raft nodes before linearized reading'  (duration: 596.411235ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.818584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:31.221606Z","time spent":"596.956656ms","remote":"127.0.0.1:33238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5675,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-09-12T02:02:31.828314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.98692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:31.828391Z","caller":"traceutil/trace.go:171","msg":"trace[702596328] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:26911; }","duration":"575.113542ms","start":"2026-09-12T02:02:31.253255Z","end":"2026-09-12T02:02:31.828368Z","steps":["trace[702596328] 'agreement among raft nodes before linearized reading'  (duration: 574.967139ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.828408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.776802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-09-12T02:02:31.828438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:31.253234Z","time spent":"575.192234ms","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "}
{"level":"info","ts":"2026-09-12T02:02:31.828469Z","caller":"traceutil/trace.go:171","msg":"trace[1822971885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26911; }","duration":"123.860584ms","start":"2026-09-12T02:02:31.704591Z","end":"2026-09-12T02:02:31.828451Z","steps":["trace[1822971885] 'agreement among raft nodes before linearized reading'  (duration: 123.69936ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:31.828408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.514498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T02:02:31.828861Z","caller":"traceutil/trace.go:171","msg":"trace[1498889797] transaction","detail":"{read_only:false; response_revision:26911; number_of_response:1; }","duration":"108.368355ms","start":"2026-09-12T02:02:31.720059Z","end":"2026-09-12T02:02:31.828427Z","steps":["trace[1498889797] 'process raft request'  (duration: 107.992777ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:31.828834Z","caller":"traceutil/trace.go:171","msg":"trace[867343145] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26911; }","duration":"163.955608ms","start":"2026-09-12T02:02:31.664829Z","end":"2026-09-12T02:02:31.828785Z","steps":["trace[867343145] 'agreement among raft nodes before linearized reading'  (duration: 163.515128ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:32.226231Z","caller":"traceutil/trace.go:171","msg":"trace[1704820004] transaction","detail":"{read_only:false; response_revision:26913; number_of_response:1; }","duration":"127.200885ms","start":"2026-09-12T02:02:32.099007Z","end":"2026-09-12T02:02:32.226208Z","steps":["trace[1704820004] 'process raft request'  (duration: 127.045342ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:32.579272Z","caller":"traceutil/trace.go:171","msg":"trace[693774511] transaction","detail":"{read_only:false; response_revision:26914; number_of_response:1; }","duration":"480.208244ms","start":"2026-09-12T02:02:32.099035Z","end":"2026-09-12T02:02:32.579244Z","steps":["trace[693774511] 'process raft request'  (duration: 479.975349ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:32.579452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:32.099003Z","time spent":"480.357506ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26899 > 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-09-12T02:02:32.579477Z","caller":"traceutil/trace.go:171","msg":"trace[745107382] linearizableReadLoop","detail":"{readStateIndex:27795; appliedIndex:27792; }","duration":"364.369929ms","start":"2026-09-12T02:02:32.215072Z","end":"2026-09-12T02:02:32.579442Z","steps":["trace[745107382] 'read index received'  (duration: 11.035914ms)","trace[745107382] 'applied index is now lower than readState.Index'  (duration: 353.331365ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:32.579619Z","caller":"traceutil/trace.go:171","msg":"trace[1682255869] transaction","detail":"{read_only:false; response_revision:26915; number_of_response:1; }","duration":"479.835065ms","start":"2026-09-12T02:02:32.099733Z","end":"2026-09-12T02:02:32.579568Z","steps":["trace[1682255869] 'process raft request'  (duration: 479.466557ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:32.579818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.731147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-09-12T02:02:32.579896Z","caller":"traceutil/trace.go:171","msg":"trace[623955659] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:26915; }","duration":"364.85858ms","start":"2026-09-12T02:02:32.215015Z","end":"2026-09-12T02:02:32.579874Z","steps":["trace[623955659] 'agreement among raft nodes before linearized reading'  (duration: 364.609935ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:32.579916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:32.099712Z","time spent":"480.018609ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26900 > 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-09-12T02:02:32.579946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:32.214989Z","time spent":"364.945011ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" "}
{"level":"warn","ts":"2026-09-12T02:02:32.741937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.608894ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955164177 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:26901 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:02:32.742155Z","caller":"traceutil/trace.go:171","msg":"trace[1735585257] linearizableReadLoop","detail":"{readStateIndex:27797; appliedIndex:27795; }","duration":"162.493336ms","start":"2026-09-12T02:02:32.579638Z","end":"2026-09-12T02:02:32.742131Z","steps":["trace[1735585257] 'read index received'  (duration: 58.481614ms)","trace[1735585257] 'applied index is now lower than readState.Index'  (duration: 104.010302ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:32.742229Z","caller":"traceutil/trace.go:171","msg":"trace[20501303] transaction","detail":"{read_only:false; response_revision:26916; number_of_response:1; }","duration":"510.257082ms","start":"2026-09-12T02:02:32.231882Z","end":"2026-09-12T02:02:32.742139Z","steps":["trace[20501303] 'process raft request'  (duration: 406.327202ms)","trace[20501303] 'compare'  (duration: 103.45422ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:32.742336Z","caller":"traceutil/trace.go:171","msg":"trace[981242570] transaction","detail":"{read_only:false; response_revision:26917; number_of_response:1; }","duration":"500.990966ms","start":"2026-09-12T02:02:32.241303Z","end":"2026-09-12T02:02:32.742294Z","steps":["trace[981242570] 'process raft request'  (duration: 500.74331ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:32.742446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.909401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ccc16261-036f-4b57-bc96-714ab6f73d3f\" ","response":"range_response_count:1 size:1324"}
{"level":"warn","ts":"2026-09-12T02:02:32.742451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.530125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T02:02:32.7425Z","caller":"traceutil/trace.go:171","msg":"trace[393973885] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ccc16261-036f-4b57-bc96-714ab6f73d3f; range_end:; response_count:1; response_revision:26917; }","duration":"158.985192ms","start":"2026-09-12T02:02:32.583498Z","end":"2026-09-12T02:02:32.742483Z","steps":["trace[393973885] 'agreement among raft nodes before linearized reading'  (duration: 158.769427ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:32.742527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:32.241275Z","time spent":"501.148529ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26902 > 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-09-12T02:02:32.742566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:32.231837Z","time spent":"510.506648ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26901 > 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-09-12T02:02:32.742545Z","caller":"traceutil/trace.go:171","msg":"trace[1352797988] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:26917; }","duration":"294.790599ms","start":"2026-09-12T02:02:32.447732Z","end":"2026-09-12T02:02:32.742523Z","steps":["trace[1352797988] 'agreement among raft nodes before linearized reading'  (duration: 294.517284ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:38.248951Z","caller":"traceutil/trace.go:171","msg":"trace[1147373389] transaction","detail":"{read_only:false; response_revision:27013; number_of_response:1; }","duration":"166.968432ms","start":"2026-09-12T02:02:38.081954Z","end":"2026-09-12T02:02:38.248923Z","steps":["trace[1147373389] 'process raft request'  (duration: 166.764088ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:38.432247Z","caller":"traceutil/trace.go:171","msg":"trace[17212422] transaction","detail":"{read_only:false; response_revision:27014; number_of_response:1; }","duration":"187.873996ms","start":"2026-09-12T02:02:38.24434Z","end":"2026-09-12T02:02:38.432214Z","steps":["trace[17212422] 'process raft request'  (duration: 118.570572ms)","trace[17212422] 'compare'  (duration: 68.966107ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:38.759638Z","caller":"traceutil/trace.go:171","msg":"trace[242746544] transaction","detail":"{read_only:false; response_revision:27015; number_of_response:1; }","duration":"161.238799ms","start":"2026-09-12T02:02:38.598368Z","end":"2026-09-12T02:02:38.759607Z","steps":["trace[242746544] 'process raft request'  (duration: 161.046665ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:38.927315Z","caller":"traceutil/trace.go:171","msg":"trace[441416665] transaction","detail":"{read_only:false; response_revision:27016; number_of_response:1; }","duration":"326.021104ms","start":"2026-09-12T02:02:38.601259Z","end":"2026-09-12T02:02:38.92728Z","steps":["trace[441416665] 'process raft request'  (duration: 266.060319ms)","trace[441416665] 'compare'  (duration: 59.627698ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:38.927501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:02:38.601234Z","time spent":"326.163688ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26946 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-09-12T02:02:38.933453Z","caller":"traceutil/trace.go:171","msg":"trace[1615616323] linearizableReadLoop","detail":"{readStateIndex:27899; appliedIndex:27896; }","duration":"158.44013ms","start":"2026-09-12T02:02:38.77499Z","end":"2026-09-12T02:02:38.933431Z","steps":["trace[1615616323] 'read index received'  (duration: 92.412005ms)","trace[1615616323] 'applied index is now lower than readState.Index'  (duration: 66.026855ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:38.933624Z","caller":"traceutil/trace.go:171","msg":"trace[1729490459] transaction","detail":"{read_only:false; response_revision:27017; number_of_response:1; }","duration":"171.064469ms","start":"2026-09-12T02:02:38.76253Z","end":"2026-09-12T02:02:38.933595Z","steps":["trace[1729490459] 'process raft request'  (duration: 170.409755ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:38.933618Z","caller":"traceutil/trace.go:171","msg":"trace[211602947] transaction","detail":"{read_only:false; response_revision:27018; number_of_response:1; }","duration":"162.470945ms","start":"2026-09-12T02:02:38.771102Z","end":"2026-09-12T02:02:38.933573Z","steps":["trace[211602947] 'process raft request'  (duration: 161.975285ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:38.933822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.822358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-09-12T02:02:38.933836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.701582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:38.933884Z","caller":"traceutil/trace.go:171","msg":"trace[127515194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27018; }","duration":"158.91593ms","start":"2026-09-12T02:02:38.774951Z","end":"2026-09-12T02:02:38.933867Z","steps":["trace[127515194] 'agreement among raft nodes before linearized reading'  (duration: 158.684255ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:38.933914Z","caller":"traceutil/trace.go:171","msg":"trace[260492717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27018; }","duration":"139.873055ms","start":"2026-09-12T02:02:38.794021Z","end":"2026-09-12T02:02:38.933894Z","steps":["trace[260492717] 'agreement among raft nodes before linearized reading'  (duration: 139.699721ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:41.334938Z","caller":"traceutil/trace.go:171","msg":"trace[1228111671] transaction","detail":"{read_only:false; response_revision:27041; number_of_response:1; }","duration":"105.427082ms","start":"2026-09-12T02:02:41.229484Z","end":"2026-09-12T02:02:41.334911Z","steps":["trace[1228111671] 'process raft request'  (duration: 105.017743ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:41.550169Z","caller":"traceutil/trace.go:171","msg":"trace[297963374] transaction","detail":"{read_only:false; response_revision:27042; number_of_response:1; }","duration":"210.63705ms","start":"2026-09-12T02:02:41.339497Z","end":"2026-09-12T02:02:41.550134Z","steps":["trace[297963374] 'process raft request'  (duration: 173.848418ms)","trace[297963374] 'compare'  (duration: 36.67001ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:46.630215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.600245ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955164629 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:27077 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:02:46.630347Z","caller":"traceutil/trace.go:171","msg":"trace[1025387500] transaction","detail":"{read_only:false; response_revision:27100; number_of_response:1; }","duration":"165.428529ms","start":"2026-09-12T02:02:46.464894Z","end":"2026-09-12T02:02:46.630322Z","steps":["trace[1025387500] 'process raft request'  (duration: 44.600009ms)","trace[1025387500] 'compare'  (duration: 120.497742ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:46.952226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.653774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:46.952317Z","caller":"traceutil/trace.go:171","msg":"trace[1097320378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27100; }","duration":"158.812577ms","start":"2026-09-12T02:02:46.793483Z","end":"2026-09-12T02:02:46.952295Z","steps":["trace[1097320378] 'range keys from in-memory index tree'  (duration: 158.529031ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:46.95251Z","caller":"traceutil/trace.go:171","msg":"trace[1639716794] transaction","detail":"{read_only:false; response_revision:27101; number_of_response:1; }","duration":"156.713334ms","start":"2026-09-12T02:02:46.795755Z","end":"2026-09-12T02:02:46.952469Z","steps":["trace[1639716794] 'process raft request'  (duration: 154.164109ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:47.167308Z","caller":"traceutil/trace.go:171","msg":"trace[824012788] linearizableReadLoop","detail":"{readStateIndex:27986; appliedIndex:27985; }","duration":"193.72566ms","start":"2026-09-12T02:02:46.973563Z","end":"2026-09-12T02:02:47.167288Z","steps":["trace[824012788] 'read index received'  (duration: 137.077465ms)","trace[824012788] 'applied index is now lower than readState.Index'  (duration: 56.647295ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:47.167384Z","caller":"traceutil/trace.go:171","msg":"trace[851856402] transaction","detail":"{read_only:false; response_revision:27102; number_of_response:1; }","duration":"195.558569ms","start":"2026-09-12T02:02:46.971739Z","end":"2026-09-12T02:02:47.167297Z","steps":["trace[851856402] 'process raft request'  (duration: 138.925405ms)","trace[851856402] 'compare'  (duration: 56.485641ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:02:47.16754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.957985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:685"}
{"level":"info","ts":"2026-09-12T02:02:47.16757Z","caller":"traceutil/trace.go:171","msg":"trace[1402344615] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:27103; }","duration":"193.999846ms","start":"2026-09-12T02:02:46.973559Z","end":"2026-09-12T02:02:47.167559Z","steps":["trace[1402344615] 'agreement among raft nodes before linearized reading'  (duration: 193.853403ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:47.167564Z","caller":"traceutil/trace.go:171","msg":"trace[1378940588] transaction","detail":"{read_only:false; response_revision:27104; number_of_response:1; }","duration":"182.351708ms","start":"2026-09-12T02:02:46.985186Z","end":"2026-09-12T02:02:47.167537Z","steps":["trace[1378940588] 'process raft request'  (duration: 182.271897ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:47.167837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.852886ms","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-09-12T02:02:47.167835Z","caller":"traceutil/trace.go:171","msg":"trace[1609135864] transaction","detail":"{read_only:false; response_revision:27103; number_of_response:1; }","duration":"187.743323ms","start":"2026-09-12T02:02:46.980079Z","end":"2026-09-12T02:02:47.167823Z","steps":["trace[1609135864] 'process raft request'  (duration: 187.185902ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:47.16786Z","caller":"traceutil/trace.go:171","msg":"trace[1935404975] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27104; }","duration":"133.914458ms","start":"2026-09-12T02:02:47.033937Z","end":"2026-09-12T02:02:47.167851Z","steps":["trace[1935404975] 'agreement among raft nodes before linearized reading'  (duration: 133.799835ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:47.168245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.546347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T02:02:47.168297Z","caller":"traceutil/trace.go:171","msg":"trace[1499766085] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27104; }","duration":"130.68833ms","start":"2026-09-12T02:02:47.037594Z","end":"2026-09-12T02:02:47.168282Z","steps":["trace[1499766085] 'agreement among raft nodes before linearized reading'  (duration: 130.414953ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:50.793237Z","caller":"traceutil/trace.go:171","msg":"trace[808792607] transaction","detail":"{read_only:false; response_revision:27134; number_of_response:1; }","duration":"181.577812ms","start":"2026-09-12T02:02:50.61161Z","end":"2026-09-12T02:02:50.793188Z","steps":["trace[808792607] 'process raft request'  (duration: 98.819151ms)","trace[808792607] 'compare'  (duration: 82.324411ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:50.949546Z","caller":"traceutil/trace.go:171","msg":"trace[726209290] transaction","detail":"{read_only:false; response_revision:27135; number_of_response:1; }","duration":"272.005705ms","start":"2026-09-12T02:02:50.677493Z","end":"2026-09-12T02:02:50.949499Z","steps":["trace[726209290] 'process raft request'  (duration: 271.708689ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:50.950198Z","caller":"traceutil/trace.go:171","msg":"trace[1708089788] linearizableReadLoop","detail":"{readStateIndex:28021; appliedIndex:28019; }","duration":"156.261293ms","start":"2026-09-12T02:02:50.793913Z","end":"2026-09-12T02:02:50.950175Z","steps":["trace[1708089788] 'read index received'  (duration: 155.431815ms)","trace[1708089788] 'applied index is now lower than readState.Index'  (duration: 828.508µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:50.950304Z","caller":"traceutil/trace.go:171","msg":"trace[978876809] transaction","detail":"{read_only:false; response_revision:27136; number_of_response:1; }","duration":"239.565845ms","start":"2026-09-12T02:02:50.710711Z","end":"2026-09-12T02:02:50.950277Z","steps":["trace[978876809] 'process raft request'  (duration: 239.33095ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:50.950366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.436597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:02:50.950394Z","caller":"traceutil/trace.go:171","msg":"trace[1818302693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27136; }","duration":"156.520529ms","start":"2026-09-12T02:02:50.793866Z","end":"2026-09-12T02:02:50.950387Z","steps":["trace[1818302693] 'agreement among raft nodes before linearized reading'  (duration: 156.417176ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:50.950752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.905403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"}
{"level":"info","ts":"2026-09-12T02:02:50.950843Z","caller":"traceutil/trace.go:171","msg":"trace[954750631] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:27136; }","duration":"154.043156ms","start":"2026-09-12T02:02:50.796784Z","end":"2026-09-12T02:02:50.950827Z","steps":["trace[954750631] 'agreement among raft nodes before linearized reading'  (duration: 153.78413ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:51.750837Z","caller":"traceutil/trace.go:171","msg":"trace[1391041927] linearizableReadLoop","detail":"{readStateIndex:28028; appliedIndex:28027; }","duration":"114.799982ms","start":"2026-09-12T02:02:51.635999Z","end":"2026-09-12T02:02:51.750799Z","steps":["trace[1391041927] 'read index received'  (duration: 114.427604ms)","trace[1391041927] 'applied index is now lower than readState.Index'  (duration: 370.608µs)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:02:51.750891Z","caller":"traceutil/trace.go:171","msg":"trace[1306492065] transaction","detail":"{read_only:false; response_revision:27143; number_of_response:1; }","duration":"122.039725ms","start":"2026-09-12T02:02:51.628826Z","end":"2026-09-12T02:02:51.750866Z","steps":["trace[1306492065] 'process raft request'  (duration: 121.706298ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:02:51.751143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.116328ms","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-09-12T02:02:51.751178Z","caller":"traceutil/trace.go:171","msg":"trace[1513258141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27143; }","duration":"115.19479ms","start":"2026-09-12T02:02:51.635973Z","end":"2026-09-12T02:02:51.751168Z","steps":["trace[1513258141] 'agreement among raft nodes before linearized reading'  (duration: 114.945884ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:51.890148Z","caller":"traceutil/trace.go:171","msg":"trace[1239411782] transaction","detail":"{read_only:false; response_revision:27144; number_of_response:1; }","duration":"135.302237ms","start":"2026-09-12T02:02:51.754815Z","end":"2026-09-12T02:02:51.890117Z","steps":["trace[1239411782] 'process raft request'  (duration: 125.902117ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:02:57.136119Z","caller":"traceutil/trace.go:171","msg":"trace[203336302] transaction","detail":"{read_only:false; response_revision:27182; number_of_response:1; }","duration":"133.055301ms","start":"2026-09-12T02:02:57.003031Z","end":"2026-09-12T02:02:57.136087Z","steps":["trace[203336302] 'process raft request'  (duration: 132.52915ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:04.600719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.232249ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955164976 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18d4706b01e82504\" mod_revision:27162 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18d4706b01e82504\" value_size:647 lease:918066452955164123 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18d4706b01e82504\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:03:04.600833Z","caller":"traceutil/trace.go:171","msg":"trace[1422903008] linearizableReadLoop","detail":"{readStateIndex:28133; appliedIndex:28132; }","duration":"336.508147ms","start":"2026-09-12T02:03:04.264308Z","end":"2026-09-12T02:03:04.600816Z","steps":["trace[1422903008] 'read index received'  (duration: 87.991482ms)","trace[1422903008] 'applied index is now lower than readState.Index'  (duration: 248.515455ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:04.600968Z","caller":"traceutil/trace.go:171","msg":"trace[1069806037] transaction","detail":"{read_only:false; response_revision:27246; number_of_response:1; }","duration":"340.799948ms","start":"2026-09-12T02:03:04.260104Z","end":"2026-09-12T02:03:04.600904Z","steps":["trace[1069806037] 'process raft request'  (duration: 92.310244ms)","trace[1069806037] 'compare'  (duration: 248.129686ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:04.601023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.711202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9650"}
{"level":"info","ts":"2026-09-12T02:03:04.601053Z","caller":"traceutil/trace.go:171","msg":"trace[26265159] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:27246; }","duration":"336.761294ms","start":"2026-09-12T02:03:04.26428Z","end":"2026-09-12T02:03:04.601042Z","steps":["trace[26265159] 'agreement among raft nodes before linearized reading'  (duration: 336.61168ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:04.601082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:04.264268Z","time spent":"336.806394ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9673,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "}
{"level":"warn","ts":"2026-09-12T02:03:04.60116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:04.260087Z","time spent":"340.963972ms","remote":"127.0.0.1:52396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":724,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18d4706b01e82504\" mod_revision:27162 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18d4706b01e82504\" value_size:647 lease:918066452955164123 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18d4706b01e82504\" > >"}
{"level":"warn","ts":"2026-09-12T02:03:04.60112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.86136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:03:04.601418Z","caller":"traceutil/trace.go:171","msg":"trace[1595050261] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:27246; }","duration":"152.219008ms","start":"2026-09-12T02:03:04.449172Z","end":"2026-09-12T02:03:04.601391Z","steps":["trace[1595050261] 'agreement among raft nodes before linearized reading'  (duration: 151.85585ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:08.111015Z","caller":"traceutil/trace.go:171","msg":"trace[104315148] transaction","detail":"{read_only:false; response_revision:27275; number_of_response:1; }","duration":"101.037589ms","start":"2026-09-12T02:03:08.009957Z","end":"2026-09-12T02:03:08.110995Z","steps":["trace[104315148] 'process raft request'  (duration: 22.404767ms)","trace[104315148] 'compare'  (duration: 78.410557ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:08.111218Z","caller":"traceutil/trace.go:171","msg":"trace[1415605240] transaction","detail":"{read_only:false; response_revision:27276; number_of_response:1; }","duration":"100.404505ms","start":"2026-09-12T02:03:08.010801Z","end":"2026-09-12T02:03:08.111206Z","steps":["trace[1415605240] 'process raft request'  (duration: 100.111838ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:08.637902Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":918066452955165056,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-12T02:03:08.68484Z","caller":"traceutil/trace.go:171","msg":"trace[981596985] transaction","detail":"{read_only:false; response_revision:27277; number_of_response:1; }","duration":"569.662695ms","start":"2026-09-12T02:03:08.115159Z","end":"2026-09-12T02:03:08.684821Z","steps":["trace[981596985] 'process raft request'  (duration: 552.093102ms)","trace[981596985] 'compare'  (duration: 17.346469ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:08.684945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.115139Z","time spent":"569.744148ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:27263 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-12T02:03:08.687674Z","caller":"traceutil/trace.go:171","msg":"trace[1832065142] linearizableReadLoop","detail":"{readStateIndex:28166; appliedIndex:28164; }","duration":"550.665051ms","start":"2026-09-12T02:03:08.136988Z","end":"2026-09-12T02:03:08.687653Z","steps":["trace[1832065142] 'read index received'  (duration: 530.39051ms)","trace[1832065142] 'applied index is now lower than readState.Index'  (duration: 20.265621ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:08.68783Z","caller":"traceutil/trace.go:171","msg":"trace[1893152024] transaction","detail":"{read_only:false; response_revision:27278; number_of_response:1; }","duration":"571.295461ms","start":"2026-09-12T02:03:08.116507Z","end":"2026-09-12T02:03:08.687803Z","steps":["trace[1893152024] 'process raft request'  (duration: 571.017215ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:08.687855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.869264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T02:03:08.687859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.874386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"warn","ts":"2026-09-12T02:03:08.687866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.053258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-12T02:03:08.687896Z","caller":"traceutil/trace.go:171","msg":"trace[1847343186] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:27278; }","duration":"550.946757ms","start":"2026-09-12T02:03:08.13694Z","end":"2026-09-12T02:03:08.687887Z","steps":["trace[1847343186] 'agreement among raft nodes before linearized reading'  (duration: 550.804164ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:08.687893Z","caller":"traceutil/trace.go:171","msg":"trace[1963655536] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:27278; }","duration":"455.966087ms","start":"2026-09-12T02:03:08.231917Z","end":"2026-09-12T02:03:08.687883Z","steps":["trace[1963655536] 'agreement among raft nodes before linearized reading'  (duration: 455.889005ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:08.687922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.136925Z","time spent":"550.990868ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" "}
{"level":"warn","ts":"2026-09-12T02:03:08.687924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.231895Z","time spent":"456.021428ms","remote":"127.0.0.1:52724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true "}
{"level":"info","ts":"2026-09-12T02:03:08.687925Z","caller":"traceutil/trace.go:171","msg":"trace[1842183302] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:27278; }","duration":"100.16355ms","start":"2026-09-12T02:03:08.587747Z","end":"2026-09-12T02:03:08.687911Z","steps":["trace[1842183302] 'agreement among raft nodes before linearized reading'  (duration: 100.074948ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:08.687927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:08.116476Z","time spent":"571.403783ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:27264 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-09-12T02:03:09.183926Z","caller":"traceutil/trace.go:171","msg":"trace[452523939] linearizableReadLoop","detail":"{readStateIndex:28167; appliedIndex:28166; }","duration":"113.649847ms","start":"2026-09-12T02:03:09.070253Z","end":"2026-09-12T02:03:09.183903Z","steps":["trace[452523939] 'read index received'  (duration: 113.400922ms)","trace[452523939] 'applied index is now lower than readState.Index'  (duration: 248.115µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:09.184093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.824231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:03:09.184166Z","caller":"traceutil/trace.go:171","msg":"trace[1666778269] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:27279; }","duration":"113.948884ms","start":"2026-09-12T02:03:09.070203Z","end":"2026-09-12T02:03:09.184152Z","steps":["trace[1666778269] 'agreement among raft nodes before linearized reading'  (duration: 113.82352ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:09.184467Z","caller":"traceutil/trace.go:171","msg":"trace[1567077661] transaction","detail":"{read_only:false; response_revision:27279; number_of_response:1; }","duration":"136.339219ms","start":"2026-09-12T02:03:09.047629Z","end":"2026-09-12T02:03:09.183968Z","steps":["trace[1567077661] 'process raft request'  (duration: 136.092294ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:09.363399Z","caller":"traceutil/trace.go:171","msg":"trace[306386834] linearizableReadLoop","detail":"{readStateIndex:28168; appliedIndex:28167; }","duration":"154.138669ms","start":"2026-09-12T02:03:09.209239Z","end":"2026-09-12T02:03:09.363378Z","steps":["trace[306386834] 'read index received'  (duration: 127.947311ms)","trace[306386834] 'applied index is now lower than readState.Index'  (duration: 26.190638ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:09.363481Z","caller":"traceutil/trace.go:171","msg":"trace[1333424588] transaction","detail":"{read_only:false; response_revision:27280; number_of_response:1; }","duration":"156.08803ms","start":"2026-09-12T02:03:09.207363Z","end":"2026-09-12T02:03:09.363451Z","steps":["trace[1333424588] 'process raft request'  (duration: 129.8123ms)","trace[1333424588] 'compare'  (duration: 26.097155ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:09.363593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.337203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9547"}
{"level":"info","ts":"2026-09-12T02:03:09.363622Z","caller":"traceutil/trace.go:171","msg":"trace[442173482] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:27280; }","duration":"154.401325ms","start":"2026-09-12T02:03:09.209212Z","end":"2026-09-12T02:03:09.363614Z","steps":["trace[442173482] 'agreement among raft nodes before linearized reading'  (duration: 154.272082ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:09.367931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.743204ms","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-09-12T02:03:09.368019Z","caller":"traceutil/trace.go:171","msg":"trace[387797615] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:27283; }","duration":"125.883688ms","start":"2026-09-12T02:03:09.242113Z","end":"2026-09-12T02:03:09.367996Z","steps":["trace[387797615] 'agreement among raft nodes before linearized reading'  (duration: 125.706234ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:10.654312Z","caller":"traceutil/trace.go:171","msg":"trace[96321502] transaction","detail":"{read_only:false; response_revision:27292; number_of_response:1; }","duration":"164.551229ms","start":"2026-09-12T02:03:10.489721Z","end":"2026-09-12T02:03:10.654272Z","steps":["trace[96321502] 'process raft request'  (duration: 106.549117ms)","trace[96321502] 'compare'  (duration: 57.695236ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:13.753836Z","caller":"traceutil/trace.go:171","msg":"trace[1478500510] transaction","detail":"{read_only:false; response_revision:27316; number_of_response:1; }","duration":"186.236731ms","start":"2026-09-12T02:03:13.567571Z","end":"2026-09-12T02:03:13.753808Z","steps":["trace[1478500510] 'process raft request'  (duration: 186.045647ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:13.768918Z","caller":"traceutil/trace.go:171","msg":"trace[2099135943] transaction","detail":"{read_only:false; response_revision:27317; number_of_response:1; }","duration":"101.773894ms","start":"2026-09-12T02:03:13.667119Z","end":"2026-09-12T02:03:13.768893Z","steps":["trace[2099135943] 'process raft request'  (duration: 101.5954ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:15.87571Z","caller":"traceutil/trace.go:171","msg":"trace[1599572102] transaction","detail":"{read_only:false; response_revision:27330; number_of_response:1; }","duration":"116.209572ms","start":"2026-09-12T02:03:15.759472Z","end":"2026-09-12T02:03:15.875681Z","steps":["trace[1599572102] 'process raft request'  (duration: 116.029868ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:16.074021Z","caller":"traceutil/trace.go:171","msg":"trace[730482088] linearizableReadLoop","detail":"{readStateIndex:28220; appliedIndex:28218; }","duration":"275.869606ms","start":"2026-09-12T02:03:15.798118Z","end":"2026-09-12T02:03:16.073988Z","steps":["trace[730482088] 'read index received'  (duration: 77.517068ms)","trace[730482088] 'applied index is now lower than readState.Index'  (duration: 198.349428ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:16.074258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.114702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T02:03:16.074263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.781551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:03:16.074341Z","caller":"traceutil/trace.go:171","msg":"trace[1908020679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27331; }","duration":"276.253115ms","start":"2026-09-12T02:03:15.798067Z","end":"2026-09-12T02:03:16.07432Z","steps":["trace[1908020679] 'agreement among raft nodes before linearized reading'  (duration: 276.116662ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:16.074376Z","caller":"traceutil/trace.go:171","msg":"trace[1364551240] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:27331; }","duration":"169.983875ms","start":"2026-09-12T02:03:15.904369Z","end":"2026-09-12T02:03:16.074353Z","steps":["trace[1364551240] 'agreement among raft nodes before linearized reading'  (duration: 169.801941ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:18.496027Z","caller":"traceutil/trace.go:171","msg":"trace[742374645] transaction","detail":"{read_only:false; response_revision:27349; number_of_response:1; }","duration":"323.698005ms","start":"2026-09-12T02:03:18.172293Z","end":"2026-09-12T02:03:18.495991Z","steps":["trace[742374645] 'process raft request'  (duration: 323.425978ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:18.496255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:18.172255Z","time spent":"323.890369ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:27334 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-12T02:03:18.747535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.703659ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955165229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:27335 > 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-09-12T02:03:18.74766Z","caller":"traceutil/trace.go:171","msg":"trace[1384633374] linearizableReadLoop","detail":"{readStateIndex:28240; appliedIndex:28238; }","duration":"482.152975ms","start":"2026-09-12T02:03:18.265455Z","end":"2026-09-12T02:03:18.747608Z","steps":["trace[1384633374] 'read index received'  (duration: 229.275247ms)","trace[1384633374] 'applied index is now lower than readState.Index'  (duration: 252.876408ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:18.747901Z","caller":"traceutil/trace.go:171","msg":"trace[826807660] transaction","detail":"{read_only:false; response_revision:27350; number_of_response:1; }","duration":"540.120816ms","start":"2026-09-12T02:03:18.207749Z","end":"2026-09-12T02:03:18.74787Z","steps":["trace[826807660] 'process raft request'  (duration: 424.997868ms)","trace[826807660] 'compare'  (duration: 114.353712ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:18.747986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.523353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T02:03:18.748046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:18.207718Z","time spent":"540.24689ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:27335 > 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-09-12T02:03:18.748076Z","caller":"traceutil/trace.go:171","msg":"trace[1860307474] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:27350; }","duration":"482.626806ms","start":"2026-09-12T02:03:18.265407Z","end":"2026-09-12T02:03:18.748034Z","steps":["trace[1860307474] 'agreement among raft nodes before linearized reading'  (duration: 482.490452ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:18.748143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:18.265382Z","time spent":"482.721757ms","remote":"127.0.0.1:52422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"info","ts":"2026-09-12T02:03:25.555332Z","caller":"traceutil/trace.go:171","msg":"trace[1740933802] transaction","detail":"{read_only:false; response_revision:27396; number_of_response:1; }","duration":"129.545076ms","start":"2026-09-12T02:03:25.425751Z","end":"2026-09-12T02:03:25.555296Z","steps":["trace[1740933802] 'process raft request'  (duration: 129.28873ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:25.593873Z","caller":"traceutil/trace.go:171","msg":"trace[375939719] transaction","detail":"{read_only:false; response_revision:27398; number_of_response:1; }","duration":"146.354112ms","start":"2026-09-12T02:03:25.447485Z","end":"2026-09-12T02:03:25.593839Z","steps":["trace[375939719] 'process raft request'  (duration: 146.269281ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:25.593874Z","caller":"traceutil/trace.go:171","msg":"trace[1163205873] transaction","detail":"{read_only:false; response_revision:27397; number_of_response:1; }","duration":"148.216612ms","start":"2026-09-12T02:03:25.445619Z","end":"2026-09-12T02:03:25.593835Z","steps":["trace[1163205873] 'process raft request'  (duration: 147.983748ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:25.594243Z","caller":"traceutil/trace.go:171","msg":"trace[703072979] transaction","detail":"{read_only:false; response_revision:27399; number_of_response:1; }","duration":"144.911722ms","start":"2026-09-12T02:03:25.449318Z","end":"2026-09-12T02:03:25.59423Z","steps":["trace[703072979] 'process raft request'  (duration: 144.484153ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:25.594295Z","caller":"traceutil/trace.go:171","msg":"trace[1543039908] transaction","detail":"{read_only:false; response_revision:27400; number_of_response:1; }","duration":"106.220649ms","start":"2026-09-12T02:03:25.488066Z","end":"2026-09-12T02:03:25.594286Z","steps":["trace[1543039908] 'process raft request'  (duration: 106.005434ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:25.757345Z","caller":"traceutil/trace.go:171","msg":"trace[1157890153] transaction","detail":"{read_only:false; response_revision:27401; number_of_response:1; }","duration":"157.712125ms","start":"2026-09-12T02:03:25.599605Z","end":"2026-09-12T02:03:25.757317Z","steps":["trace[1157890153] 'process raft request'  (duration: 152.069185ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:26.153519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.118841ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955165343 > lease_revoke:<id:0cbda093289871a4>","response":"size:29"}
{"level":"info","ts":"2026-09-12T02:03:26.153746Z","caller":"traceutil/trace.go:171","msg":"trace[2088017251] linearizableReadLoop","detail":"{readStateIndex:28293; appliedIndex:28292; }","duration":"359.312732ms","start":"2026-09-12T02:03:25.794415Z","end":"2026-09-12T02:03:26.153728Z","steps":["trace[2088017251] 'read index received'  (duration: 123.863654ms)","trace[2088017251] 'applied index is now lower than readState.Index'  (duration: 235.447917ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:26.153848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.435105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:03:26.153879Z","caller":"traceutil/trace.go:171","msg":"trace[596209476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27401; }","duration":"359.518606ms","start":"2026-09-12T02:03:25.79435Z","end":"2026-09-12T02:03:26.153868Z","steps":["trace[596209476] 'agreement among raft nodes before linearized reading'  (duration: 359.454905ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:26.153918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T02:03:25.794326Z","time spent":"359.584267ms","remote":"127.0.0.1:52312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-12T02:03:26.153961Z","caller":"traceutil/trace.go:171","msg":"trace[411308964] transaction","detail":"{read_only:false; response_revision:27402; number_of_response:1; }","duration":"230.708587ms","start":"2026-09-12T02:03:25.923228Z","end":"2026-09-12T02:03:26.153937Z","steps":["trace[411308964] 'process raft request'  (duration: 230.40148ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:26.289988Z","caller":"traceutil/trace.go:171","msg":"trace[1173421482] linearizableReadLoop","detail":"{readStateIndex:28295; appliedIndex:28294; }","duration":"134.242115ms","start":"2026-09-12T02:03:26.155717Z","end":"2026-09-12T02:03:26.289959Z","steps":["trace[1173421482] 'read index received'  (duration: 63.988151ms)","trace[1173421482] 'applied index is now lower than readState.Index'  (duration: 70.252124ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:26.290133Z","caller":"traceutil/trace.go:171","msg":"trace[1437493235] transaction","detail":"{read_only:false; response_revision:27403; number_of_response:1; }","duration":"204.276235ms","start":"2026-09-12T02:03:26.085842Z","end":"2026-09-12T02:03:26.290118Z","steps":["trace[1437493235] 'process raft request'  (duration: 133.933198ms)","trace[1437493235] 'compare'  (duration: 69.849186ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:26.290269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.223394ms","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-09-12T02:03:26.29031Z","caller":"traceutil/trace.go:171","msg":"trace[594802417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27403; }","duration":"133.303845ms","start":"2026-09-12T02:03:26.156995Z","end":"2026-09-12T02:03:26.290299Z","steps":["trace[594802417] 'agreement among raft nodes before linearized reading'  (duration: 133.136822ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:26.290394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.665984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-12T02:03:26.29044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.79362ms","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-09-12T02:03:26.290445Z","caller":"traceutil/trace.go:171","msg":"trace[464004864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27403; }","duration":"134.754666ms","start":"2026-09-12T02:03:26.155677Z","end":"2026-09-12T02:03:26.290432Z","steps":["trace[464004864] 'agreement among raft nodes before linearized reading'  (duration: 134.674774ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:26.290472Z","caller":"traceutil/trace.go:171","msg":"trace[2020256015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27403; }","duration":"129.879902ms","start":"2026-09-12T02:03:26.160583Z","end":"2026-09-12T02:03:26.290463Z","steps":["trace[2020256015] 'agreement among raft nodes before linearized reading'  (duration: 129.79211ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:26.882098Z","caller":"traceutil/trace.go:171","msg":"trace[866489641] transaction","detail":"{read_only:false; response_revision:27407; number_of_response:1; }","duration":"107.599738ms","start":"2026-09-12T02:03:26.774465Z","end":"2026-09-12T02:03:26.882064Z","steps":["trace[866489641] 'process raft request'  (duration: 103.774587ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:27.05932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.727057ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955165355 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<key:\"compact_rev_key\" version:10 > success:<request_put:<key:\"compact_rev_key\" value_size:5 >> failure:<request_range:<key:\"compact_rev_key\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:03:27.059686Z","caller":"traceutil/trace.go:171","msg":"trace[2070608434] transaction","detail":"{read_only:false; response_revision:27408; number_of_response:1; }","duration":"176.444833ms","start":"2026-09-12T02:03:26.883187Z","end":"2026-09-12T02:03:27.059632Z","steps":["trace[2070608434] 'process raft request'  (duration: 63.299816ms)","trace[2070608434] 'compare'  (duration: 112.37722ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:27.317889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24493}
{"level":"warn","ts":"2026-09-12T02:03:27.318597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.801323ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955165358 username:\"kube-apiserver-etcd-client\" auth_revision:1 > compaction:<revision:24493 > ","response":"size:6"}
{"level":"info","ts":"2026-09-12T02:03:27.318878Z","caller":"traceutil/trace.go:171","msg":"trace[92388865] compact","detail":"{revision:24493; response_revision:27408; }","duration":"257.964537ms","start":"2026-09-12T02:03:27.060887Z","end":"2026-09-12T02:03:27.318852Z","steps":["trace[92388865] 'process raft request'  (duration: 77.903427ms)","trace[92388865] 'check and update compact revision'  (duration: 178.689241ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:27.321419Z","caller":"traceutil/trace.go:171","msg":"trace[2130883464] transaction","detail":"{read_only:false; response_revision:27409; number_of_response:1; }","duration":"257.777582ms","start":"2026-09-12T02:03:27.063627Z","end":"2026-09-12T02:03:27.321404Z","steps":["trace[2130883464] 'process raft request'  (duration: 255.118215ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:27.3227Z","caller":"traceutil/trace.go:171","msg":"trace[2055261767] transaction","detail":"{read_only:false; response_revision:27411; number_of_response:1; }","duration":"226.760753ms","start":"2026-09-12T02:03:27.095895Z","end":"2026-09-12T02:03:27.322656Z","steps":["trace[2055261767] 'process raft request'  (duration: 225.70117ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:27.323123Z","caller":"traceutil/trace.go:171","msg":"trace[1328723494] transaction","detail":"{read_only:false; response_revision:27410; number_of_response:1; }","duration":"259.119622ms","start":"2026-09-12T02:03:27.063991Z","end":"2026-09-12T02:03:27.323111Z","steps":["trace[1328723494] 'process raft request'  (duration: 255.368521ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:27.323207Z","caller":"traceutil/trace.go:171","msg":"trace[1682705944] linearizableReadLoop","detail":"{readStateIndex:28304; appliedIndex:28300; }","duration":"161.196909ms","start":"2026-09-12T02:03:27.16199Z","end":"2026-09-12T02:03:27.323187Z","steps":["trace[1682705944] 'read index received'  (duration: 98.518105ms)","trace[1682705944] 'applied index is now lower than readState.Index'  (duration: 62.676704ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-12T02:03:27.323392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.377022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:03:27.323478Z","caller":"traceutil/trace.go:171","msg":"trace[1384518777] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:27412; }","duration":"161.522485ms","start":"2026-09-12T02:03:27.161936Z","end":"2026-09-12T02:03:27.323459Z","steps":["trace[1384518777] 'agreement among raft nodes before linearized reading'  (duration: 161.306201ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:27.486005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24493,"took":"161.665959ms","hash":83462873,"current-db-size-bytes":61321216,"current-db-size":"61 MB","current-db-size-in-use-bytes":37605376,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-09-12T02:03:27.486076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":83462873,"revision":24493,"compact-revision":21667}
{"level":"info","ts":"2026-09-12T02:03:30.291413Z","caller":"traceutil/trace.go:171","msg":"trace[1961795848] transaction","detail":"{read_only:false; response_revision:27433; number_of_response:1; }","duration":"124.827484ms","start":"2026-09-12T02:03:30.166416Z","end":"2026-09-12T02:03:30.291243Z","steps":["trace[1961795848] 'process raft request'  (duration: 124.65702ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:33.574483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.501286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-12T02:03:33.574583Z","caller":"traceutil/trace.go:171","msg":"trace[1527617769] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27457; }","duration":"186.683871ms","start":"2026-09-12T02:03:33.387875Z","end":"2026-09-12T02:03:33.574559Z","steps":["trace[1527617769] 'range keys from in-memory index tree'  (duration: 186.253461ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:33.575103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.85558ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066452955165479 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:27443 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-12T02:03:33.575319Z","caller":"traceutil/trace.go:171","msg":"trace[1189800562] transaction","detail":"{read_only:false; response_revision:27459; number_of_response:1; }","duration":"183.500432ms","start":"2026-09-12T02:03:33.391802Z","end":"2026-09-12T02:03:33.575302Z","steps":["trace[1189800562] 'process raft request'  (duration: 183.38505ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:33.575305Z","caller":"traceutil/trace.go:171","msg":"trace[1262890555] transaction","detail":"{read_only:false; response_revision:27458; number_of_response:1; }","duration":"184.909093ms","start":"2026-09-12T02:03:33.390361Z","end":"2026-09-12T02:03:33.57527Z","steps":["trace[1262890555] 'process raft request'  (duration: 63.802877ms)","trace[1262890555] 'compare'  (duration: 120.37401ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:33.753286Z","caller":"traceutil/trace.go:171","msg":"trace[1464436425] linearizableReadLoop","detail":"{readStateIndex:28355; appliedIndex:28354; }","duration":"161.408303ms","start":"2026-09-12T02:03:33.591838Z","end":"2026-09-12T02:03:33.753247Z","steps":["trace[1464436425] 'read index received'  (duration: 154.801623ms)","trace[1464436425] 'applied index is now lower than readState.Index'  (duration: 6.60487ms)"],"step_count":2}
{"level":"info","ts":"2026-09-12T02:03:33.753342Z","caller":"traceutil/trace.go:171","msg":"trace[265885505] transaction","detail":"{read_only:false; response_revision:27460; number_of_response:1; }","duration":"172.836687ms","start":"2026-09-12T02:03:33.580467Z","end":"2026-09-12T02:03:33.753304Z","steps":["trace[265885505] 'process raft request'  (duration: 166.129094ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:33.754154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.287492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-09-12T02:03:33.754218Z","caller":"traceutil/trace.go:171","msg":"trace[1103073369] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:27460; }","duration":"162.462766ms","start":"2026-09-12T02:03:33.591739Z","end":"2026-09-12T02:03:33.754202Z","steps":["trace[1103073369] 'agreement among raft nodes before linearized reading'  (duration: 161.683929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:33.781377Z","caller":"traceutil/trace.go:171","msg":"trace[1803562516] transaction","detail":"{read_only:false; response_revision:27462; number_of_response:1; }","duration":"148.325265ms","start":"2026-09-12T02:03:33.633023Z","end":"2026-09-12T02:03:33.781348Z","steps":["trace[1803562516] 'process raft request'  (duration: 148.228163ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:33.781386Z","caller":"traceutil/trace.go:171","msg":"trace[1090997048] transaction","detail":"{read_only:false; response_revision:27461; number_of_response:1; }","duration":"148.810394ms","start":"2026-09-12T02:03:33.632549Z","end":"2026-09-12T02:03:33.78136Z","steps":["trace[1090997048] 'process raft request'  (duration: 148.535779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:03:33.781595Z","caller":"traceutil/trace.go:171","msg":"trace[569818175] transaction","detail":"{read_only:false; response_revision:27463; number_of_response:1; }","duration":"147.774463ms","start":"2026-09-12T02:03:33.633809Z","end":"2026-09-12T02:03:33.781584Z","steps":["trace[569818175] 'process raft request'  (duration: 147.497797ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-12T02:03:33.78198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.078581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-12T02:03:33.782037Z","caller":"traceutil/trace.go:171","msg":"trace[418543381] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:27463; }","duration":"149.173142ms","start":"2026-09-12T02:03:33.632843Z","end":"2026-09-12T02:03:33.782016Z","steps":["trace[418543381] 'agreement among raft nodes before linearized reading'  (duration: 148.686232ms)"],"step_count":1}
{"level":"info","ts":"2026-09-12T02:06:20.587899Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T02:06:20.595515Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-12T02:06:20.595636Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-09-12T02:08:27.329493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27408}
{"level":"info","ts":"2026-09-12T02:08:27.482732Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27408,"took":"149.816076ms","hash":909877809,"current-db-size-bytes":61321216,"current-db-size":"61 MB","current-db-size-in-use-bytes":35684352,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-09-12T02:08:27.482805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":909877809,"revision":27408,"compact-revision":24493}
{"level":"info","ts":"2026-09-12T02:13:27.339811Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30319}
{"level":"info","ts":"2026-09-12T02:13:27.50447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30319,"took":"156.208983ms","hash":4050561412,"current-db-size-bytes":61321216,"current-db-size":"61 MB","current-db-size-in-use-bytes":31834112,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-12T02:13:27.504544Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4050561412,"revision":30319,"compact-revision":27408}
{"level":"info","ts":"2026-09-12T02:18:27.347722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32580}
{"level":"info","ts":"2026-09-12T02:18:27.525277Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32580,"took":"170.837223ms","hash":2759986280,"current-db-size-bytes":62361600,"current-db-size":"62 MB","current-db-size-in-use-bytes":30404608,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T02:18:27.525357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2759986280,"revision":32580,"compact-revision":30319}
{"level":"info","ts":"2026-09-12T02:23:27.355023Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34801}
{"level":"info","ts":"2026-09-12T02:23:27.487625Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34801,"took":"128.117375ms","hash":1706479834,"current-db-size-bytes":62361600,"current-db-size":"62 MB","current-db-size-in-use-bytes":30527488,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T02:23:27.487694Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1706479834,"revision":34801,"compact-revision":32580}
{"level":"info","ts":"2026-09-12T02:27:09.363864Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-12T02:27:09.370481Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-09-12T02:27:09.370584Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-09-12T02:28:27.362303Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37035}
{"level":"info","ts":"2026-09-12T02:28:27.500048Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37035,"took":"133.808036ms","hash":1524077224,"current-db-size-bytes":62361600,"current-db-size":"62 MB","current-db-size-in-use-bytes":31027200,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-12T02:28:27.500119Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1524077224,"revision":37035,"compact-revision":34801}
{"level":"info","ts":"2026-09-12T02:33:27.370089Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39367}
{"level":"info","ts":"2026-09-12T02:33:27.507884Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39367,"took":"133.133892ms","hash":589703283,"current-db-size-bytes":62361600,"current-db-size":"62 MB","current-db-size-in-use-bytes":30130176,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-12T02:33:27.507952Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":589703283,"revision":39367,"compact-revision":37035}