{"level":"warn","ts":"2026-09-09T06:19:21.763362Z","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-09T06:19:21.763497Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.160: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.160:2380","--initial-cluster=instance=https://162.253.55.160:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.160:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.160: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-09T06:19:21.763639Z","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-09T06:19:21.763654Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.160:2380"]}
{"level":"info","ts":"2026-09-09T06:19:21.763687Z","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-09T06:19:21.764573Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.160:2379"]}
{"level":"info","ts":"2026-09-09T06:19:21.764775Z","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.160:2380"],"listen-peer-urls":["https://162.253.55.160:2380"],"advertise-client-urls":["https://162.253.55.160:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.160:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.160: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-09T06:19:21.768276Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.156126ms"}
{"level":"info","ts":"2026-09-09T06:19:21.774488Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"596257f6524f82c3","cluster-id":"52bc9097ef2bef78"}
{"level":"info","ts":"2026-09-09T06:19:21.77465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-09T06:19:21.774724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 became follower at term 0"}
{"level":"info","ts":"2026-09-09T06:19:21.774753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 596257f6524f82c3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-09T06:19:21.774813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 became follower at term 1"}
{"level":"info","ts":"2026-09-09T06:19:21.774893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 switched to configuration voters=(6440807132547744451)"}
{"level":"warn","ts":"2026-09-09T06:19:21.782293Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-09T06:19:21.784291Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-09T06:19:21.786044Z","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-09T06:19:21.788753Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"596257f6524f82c3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-09T06:19:21.789013Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"596257f6524f82c3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-09T06:19:21.789108Z","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-09T06:19:21.789297Z","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-09T06:19:21.789338Z","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-09T06:19:21.791355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 switched to configuration voters=(6440807132547744451)"}
{"level":"info","ts":"2026-09-09T06:19:21.791652Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bc9097ef2bef78","local-member-id":"596257f6524f82c3","added-peer-id":"596257f6524f82c3","added-peer-peer-urls":["https://162.253.55.160:2380"]}
{"level":"info","ts":"2026-09-09T06:19:21.810817Z","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-09T06:19:21.810929Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.160:2380"}
{"level":"info","ts":"2026-09-09T06:19:21.810992Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.160:2380"}
{"level":"info","ts":"2026-09-09T06:19:21.811104Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"596257f6524f82c3","initial-advertise-peer-urls":["https://162.253.55.160:2380"],"listen-peer-urls":["https://162.253.55.160:2380"],"advertise-client-urls":["https://162.253.55.160:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.160:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-09T06:19:21.811156Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-09T06:19:22.575561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-09T06:19:22.575741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-09T06:19:22.575775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 received MsgPreVoteResp from 596257f6524f82c3 at term 1"}
{"level":"info","ts":"2026-09-09T06:19:22.575809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 became candidate at term 2"}
{"level":"info","ts":"2026-09-09T06:19:22.575821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 received MsgVoteResp from 596257f6524f82c3 at term 2"}
{"level":"info","ts":"2026-09-09T06:19:22.575838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"596257f6524f82c3 became leader at term 2"}
{"level":"info","ts":"2026-09-09T06:19:22.575852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 596257f6524f82c3 elected leader 596257f6524f82c3 at term 2"}
{"level":"info","ts":"2026-09-09T06:19:22.577317Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T06:19:22.578845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-09T06:19:22.578838Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"596257f6524f82c3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.160:2379]}","request-path":"/0/members/596257f6524f82c3/attributes","cluster-id":"52bc9097ef2bef78","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-09T06:19:22.578942Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-09T06:19:22.579195Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-09T06:19:22.579269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-09T06:19:22.579429Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bc9097ef2bef78","local-member-id":"596257f6524f82c3","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T06:19:22.579633Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T06:19:22.5797Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T06:19:22.5826Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-09T06:19:22.5827Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.160:2379"}
{"level":"info","ts":"2026-09-09T06:19:25.538575Z","caller":"traceutil/trace.go:171","msg":"trace[929615945] linearizableReadLoop","detail":"{readStateIndex:142; appliedIndex:141; }","duration":"110.490955ms","start":"2026-09-09T06:19:25.42806Z","end":"2026-09-09T06:19:25.538551Z","steps":["trace[929615945] 'read index received'  (duration: 110.454374ms)","trace[929615945] 'applied index is now lower than readState.Index'  (duration: 35.1µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:19:25.538658Z","caller":"traceutil/trace.go:171","msg":"trace[370528969] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"110.690099ms","start":"2026-09-09T06:19:25.427903Z","end":"2026-09-09T06:19:25.538593Z","steps":["trace[370528969] 'process raft request'  (duration: 110.498055ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:19:25.539048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.955116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:endpoint-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:19:25.539321Z","caller":"traceutil/trace.go:171","msg":"trace[1836968030] range","detail":"{range_begin:/registry/clusterroles/system:controller:endpoint-controller; range_end:; response_count:0; response_revision:138; }","duration":"111.078549ms","start":"2026-09-09T06:19:25.428051Z","end":"2026-09-09T06:19:25.53913Z","steps":["trace[1836968030] 'agreement among raft nodes before linearized reading'  (duration: 110.649948ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:19:38.498971Z","caller":"traceutil/trace.go:171","msg":"trace[43228024] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"197.72385ms","start":"2026-09-09T06:19:38.301218Z","end":"2026-09-09T06:19:38.498942Z","steps":["trace[43228024] 'process raft request'  (duration: 197.535705ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:04.097138Z","caller":"traceutil/trace.go:171","msg":"trace[1790784578] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"120.117915ms","start":"2026-09-09T06:20:03.976989Z","end":"2026-09-09T06:20:04.097107Z","steps":["trace[1790784578] 'read index received'  (duration: 119.940421ms)","trace[1790784578] 'applied index is now lower than readState.Index'  (duration: 176.444µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:20:04.097214Z","caller":"traceutil/trace.go:171","msg":"trace[1891020743] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"141.737806ms","start":"2026-09-09T06:20:03.955442Z","end":"2026-09-09T06:20:04.09718Z","steps":["trace[1891020743] 'process raft request'  (duration: 141.372926ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:20:04.097745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.652298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"}
{"level":"info","ts":"2026-09-09T06:20:04.097851Z","caller":"traceutil/trace.go:171","msg":"trace[962104506] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:637; }","duration":"120.871753ms","start":"2026-09-09T06:20:03.976953Z","end":"2026-09-09T06:20:04.097824Z","steps":["trace[962104506] 'agreement among raft nodes before linearized reading'  (duration: 120.27065ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:04.234864Z","caller":"traceutil/trace.go:171","msg":"trace[1893822042] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"172.190327ms","start":"2026-09-09T06:20:04.062654Z","end":"2026-09-09T06:20:04.234844Z","steps":["trace[1893822042] 'process raft request'  (duration: 171.791367ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:04.23914Z","caller":"traceutil/trace.go:171","msg":"trace[645845112] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"107.043172ms","start":"2026-09-09T06:20:04.132051Z","end":"2026-09-09T06:20:04.239094Z","steps":["trace[645845112] 'read index received'  (duration: 102.498853ms)","trace[645845112] 'applied index is now lower than readState.Index'  (duration: 4.543319ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:20:04.240988Z","caller":"traceutil/trace.go:171","msg":"trace[922094501] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"129.544663ms","start":"2026-09-09T06:20:04.111356Z","end":"2026-09-09T06:20:04.240901Z","steps":["trace[922094501] 'process raft request'  (duration: 127.066573ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:04.241511Z","caller":"traceutil/trace.go:171","msg":"trace[584034689] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"103.24888ms","start":"2026-09-09T06:20:04.138232Z","end":"2026-09-09T06:20:04.241481Z","steps":["trace[584034689] 'process raft request'  (duration: 100.583756ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:20:04.242665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.604217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:20:04.242757Z","caller":"traceutil/trace.go:171","msg":"trace[1205831834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"110.729199ms","start":"2026-09-09T06:20:04.131997Z","end":"2026-09-09T06:20:04.242726Z","steps":["trace[1205831834] 'agreement among raft nodes before linearized reading'  (duration: 108.054646ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:10.733736Z","caller":"traceutil/trace.go:171","msg":"trace[43768603] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"293.82954ms","start":"2026-09-09T06:20:10.439879Z","end":"2026-09-09T06:20:10.733709Z","steps":["trace[43768603] 'process raft request'  (duration: 293.618515ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:10.980479Z","caller":"traceutil/trace.go:171","msg":"trace[959935250] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:730; }","duration":"186.192763ms","start":"2026-09-09T06:20:10.794257Z","end":"2026-09-09T06:20:10.98045Z","steps":["trace[959935250] 'read index received'  (duration: 126.207342ms)","trace[959935250] 'applied index is now lower than readState.Index'  (duration: 59.984341ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:20:10.98058Z","caller":"traceutil/trace.go:171","msg":"trace[1198391684] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"187.005694ms","start":"2026-09-09T06:20:10.79354Z","end":"2026-09-09T06:20:10.980546Z","steps":["trace[1198391684] 'process raft request'  (duration: 126.958991ms)","trace[1198391684] 'compare'  (duration: 59.841157ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:20:10.980718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.434879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-09T06:20:10.980789Z","caller":"traceutil/trace.go:171","msg":"trace[1066502590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:706; }","duration":"186.520281ms","start":"2026-09-09T06:20:10.794252Z","end":"2026-09-09T06:20:10.980772Z","steps":["trace[1066502590] 'agreement among raft nodes before linearized reading'  (duration: 186.300066ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:20:11.222707Z","caller":"traceutil/trace.go:171","msg":"trace[1569403005] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"237.196078ms","start":"2026-09-09T06:20:10.985471Z","end":"2026-09-09T06:20:11.222668Z","steps":["trace[1569403005] 'process raft request'  (duration: 236.965903ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:20:11.954619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.300909ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9422551337711514854 > lease_revoke:<id:02c3a084d22d3328>","response":"size:27"}
{"level":"info","ts":"2026-09-09T06:21:47.371403Z","caller":"traceutil/trace.go:171","msg":"trace[890629583] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1991; }","duration":"104.134033ms","start":"2026-09-09T06:21:47.267242Z","end":"2026-09-09T06:21:47.371376Z","steps":["trace[890629583] 'read index received'  (duration: 104.066131ms)","trace[890629583] 'applied index is now lower than readState.Index'  (duration: 66.532µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:21:47.371518Z","caller":"traceutil/trace.go:171","msg":"trace[1913656557] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"402.718085ms","start":"2026-09-09T06:21:46.968768Z","end":"2026-09-09T06:21:47.371486Z","steps":["trace[1913656557] 'process raft request'  (duration: 402.477159ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:21:47.371791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.525213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18d392d1711cbf2e\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-09-09T06:21:47.371898Z","caller":"traceutil/trace.go:171","msg":"trace[879124493] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18d392d1711cbf2e; range_end:; response_count:1; response_revision:1918; }","duration":"104.686277ms","start":"2026-09-09T06:21:47.267186Z","end":"2026-09-09T06:21:47.371872Z","steps":["trace[879124493] 'agreement among raft nodes before linearized reading'  (duration: 104.364158ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:21:47.372364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:21:46.96874Z","time spent":"403.038983ms","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ad62545-9757-499e-8c14-313e77c86aae\" mod_revision:1869 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ad62545-9757-499e-8c14-313e77c86aae\" value_size:3629 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ad62545-9757-499e-8c14-313e77c86aae\" > >"}
{"level":"warn","ts":"2026-09-09T06:21:47.393138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.463125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ad62545-9757-499e-8c14-313e77c86aae\" ","response":"range_response_count:1 size:3744"}
{"level":"info","ts":"2026-09-09T06:21:47.393237Z","caller":"traceutil/trace.go:171","msg":"trace[654556603] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0ad62545-9757-499e-8c14-313e77c86aae; range_end:; response_count:1; response_revision:1919; }","duration":"107.62941ms","start":"2026-09-09T06:21:47.285589Z","end":"2026-09-09T06:21:47.393218Z","steps":["trace[654556603] 'agreement among raft nodes before linearized reading'  (duration: 107.405454ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:21:47.542311Z","caller":"traceutil/trace.go:171","msg":"trace[1017453569] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"114.765115ms","start":"2026-09-09T06:21:47.427518Z","end":"2026-09-09T06:21:47.542283Z","steps":["trace[1017453569] 'read index received'  (duration: 102.996617ms)","trace[1017453569] 'applied index is now lower than readState.Index'  (duration: 11.767468ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:21:47.542474Z","caller":"traceutil/trace.go:171","msg":"trace[2044594779] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"167.351914ms","start":"2026-09-09T06:21:47.375097Z","end":"2026-09-09T06:21:47.542449Z","steps":["trace[2044594779] 'process raft request'  (duration: 155.405302ms)","trace[2044594779] 'compare'  (duration: 11.663285ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:21:47.542583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.02253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-09T06:21:47.542627Z","caller":"traceutil/trace.go:171","msg":"trace[1116608988] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1920; }","duration":"115.153725ms","start":"2026-09-09T06:21:47.427462Z","end":"2026-09-09T06:21:47.542616Z","steps":["trace[1116608988] 'agreement among raft nodes before linearized reading'  (duration: 114.955299ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:21:47.560077Z","caller":"traceutil/trace.go:171","msg":"trace[503153949] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"101.063238ms","start":"2026-09-09T06:21:47.458986Z","end":"2026-09-09T06:21:47.560049Z","steps":["trace[503153949] 'process raft request'  (duration: 100.782932ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:21:47.840889Z","caller":"traceutil/trace.go:171","msg":"trace[1149426976] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"275.198038ms","start":"2026-09-09T06:21:47.565649Z","end":"2026-09-09T06:21:47.840847Z","steps":["trace[1149426976] 'process raft request'  (duration: 206.846662ms)","trace[1149426976] 'compare'  (duration: 67.981877ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:22:00.733334Z","caller":"traceutil/trace.go:171","msg":"trace[2137100975] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"117.571703ms","start":"2026-09-09T06:22:00.6157Z","end":"2026-09-09T06:22:00.733271Z","steps":["trace[2137100975] 'process raft request'  (duration: 117.368698ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:22:31.175293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.111135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-09T06:22:31.175674Z","caller":"traceutil/trace.go:171","msg":"trace[2123398745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2211; }","duration":"109.525596ms","start":"2026-09-09T06:22:31.066123Z","end":"2026-09-09T06:22:31.175649Z","steps":["trace[2123398745] 'range keys from in-memory index tree'  (duration: 108.962662ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:22:31.175357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.270215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-09-09T06:22:31.175822Z","caller":"traceutil/trace.go:171","msg":"trace[122470574] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2211; }","duration":"119.787388ms","start":"2026-09-09T06:22:31.056018Z","end":"2026-09-09T06:22:31.175805Z","steps":["trace[122470574] 'range keys from in-memory index tree'  (duration: 119.07992ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:22:31.175507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.364624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-09T06:22:31.175991Z","caller":"traceutil/trace.go:171","msg":"trace[231544353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2211; }","duration":"105.847956ms","start":"2026-09-09T06:22:31.070113Z","end":"2026-09-09T06:22:31.175961Z","steps":["trace[231544353] 'range keys from in-memory index tree'  (duration: 105.247771ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:22:31.453615Z","caller":"traceutil/trace.go:171","msg":"trace[445307950] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"272.163363ms","start":"2026-09-09T06:22:31.181389Z","end":"2026-09-09T06:22:31.453553Z","steps":["trace[445307950] 'process raft request'  (duration: 206.059642ms)","trace[445307950] 'compare'  (duration: 65.484346ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:22:31.453894Z","caller":"traceutil/trace.go:171","msg":"trace[208259769] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"272.05153ms","start":"2026-09-09T06:22:31.181799Z","end":"2026-09-09T06:22:31.45385Z","steps":["trace[208259769] 'process raft request'  (duration: 271.746603ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:22:37.235774Z","caller":"traceutil/trace.go:171","msg":"trace[42745168] linearizableReadLoop","detail":"{readStateIndex:2329; appliedIndex:2328; }","duration":"229.693072ms","start":"2026-09-09T06:22:37.006035Z","end":"2026-09-09T06:22:37.235728Z","steps":["trace[42745168] 'read index received'  (duration: 162.134685ms)","trace[42745168] 'applied index is now lower than readState.Index'  (duration: 67.556167ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:22:37.235866Z","caller":"traceutil/trace.go:171","msg":"trace[558867123] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"348.921946ms","start":"2026-09-09T06:22:36.886884Z","end":"2026-09-09T06:22:37.235806Z","steps":["trace[558867123] 'process raft request'  (duration: 281.312487ms)","trace[558867123] 'compare'  (duration: 67.25999ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:22:37.236021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.968999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-09-09T06:22:37.236089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:22:36.88686Z","time spent":"349.127451ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2232 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-09T06:22:37.236116Z","caller":"traceutil/trace.go:171","msg":"trace[1088780474] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2244; }","duration":"230.107913ms","start":"2026-09-09T06:22:37.005987Z","end":"2026-09-09T06:22:37.236095Z","steps":["trace[1088780474] 'agreement among raft nodes before linearized reading'  (duration: 229.883587ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:22:37.23649Z","caller":"traceutil/trace.go:171","msg":"trace[1231131717] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"195.296648ms","start":"2026-09-09T06:22:37.041172Z","end":"2026-09-09T06:22:37.236469Z","steps":["trace[1231131717] 'process raft request'  (duration: 195.125154ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:22:37.409552Z","caller":"traceutil/trace.go:171","msg":"trace[150756101] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"145.002627ms","start":"2026-09-09T06:22:37.264522Z","end":"2026-09-09T06:22:37.409525Z","steps":["trace[150756101] 'process raft request'  (duration: 131.138087ms)","trace[150756101] 'compare'  (duration: 13.647435ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:22:37.40995Z","caller":"traceutil/trace.go:171","msg":"trace[1000877439] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"144.653847ms","start":"2026-09-09T06:22:37.265166Z","end":"2026-09-09T06:22:37.40982Z","steps":["trace[1000877439] 'process raft request'  (duration: 144.301489ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:22:37.679135Z","caller":"traceutil/trace.go:171","msg":"trace[1895576112] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"196.332555ms","start":"2026-09-09T06:22:37.482775Z","end":"2026-09-09T06:22:37.679108Z","steps":["trace[1895576112] 'process raft request'  (duration: 130.412098ms)","trace[1895576112] 'compare'  (duration: 65.745922ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:22:37.679424Z","caller":"traceutil/trace.go:171","msg":"trace[1719607578] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"195.447014ms","start":"2026-09-09T06:22:37.483941Z","end":"2026-09-09T06:22:37.679388Z","steps":["trace[1719607578] 'process raft request'  (duration: 195.132415ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:27:19.237417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.468147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:27:19.239425Z","caller":"traceutil/trace.go:171","msg":"trace[831760037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4135; }","duration":"107.501717ms","start":"2026-09-09T06:27:19.131871Z","end":"2026-09-09T06:27:19.239373Z","steps":["trace[831760037] 'range keys from in-memory index tree'  (duration: 105.367005ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:27:19.373667Z","caller":"traceutil/trace.go:171","msg":"trace[2091946071] transaction","detail":"{read_only:false; response_revision:4136; number_of_response:1; }","duration":"130.599282ms","start":"2026-09-09T06:27:19.243036Z","end":"2026-09-09T06:27:19.373636Z","steps":["trace[2091946071] 'process raft request'  (duration: 130.216233ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:27:19.373664Z","caller":"traceutil/trace.go:171","msg":"trace[978832112] linearizableReadLoop","detail":"{readStateIndex:4292; appliedIndex:4291; }","duration":"130.051659ms","start":"2026-09-09T06:27:19.243569Z","end":"2026-09-09T06:27:19.373621Z","steps":["trace[978832112] 'read index received'  (duration: 129.751552ms)","trace[978832112] 'applied index is now lower than readState.Index'  (duration: 298.117µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:27:19.373899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.301545ms","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-09T06:27:19.374085Z","caller":"traceutil/trace.go:171","msg":"trace[656312048] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4136; }","duration":"130.537411ms","start":"2026-09-09T06:27:19.243529Z","end":"2026-09-09T06:27:19.374067Z","steps":["trace[656312048] 'agreement among raft nodes before linearized reading'  (duration: 130.204192ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:27:19.375322Z","caller":"traceutil/trace.go:171","msg":"trace[1961511173] transaction","detail":"{read_only:false; response_revision:4137; number_of_response:1; }","duration":"130.996351ms","start":"2026-09-09T06:27:19.244312Z","end":"2026-09-09T06:27:19.375308Z","steps":["trace[1961511173] 'process raft request'  (duration: 130.92347ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:28:53.58779Z","caller":"traceutil/trace.go:171","msg":"trace[567551702] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"239.95678ms","start":"2026-09-09T06:28:53.347796Z","end":"2026-09-09T06:28:53.587753Z","steps":["trace[567551702] 'process raft request'  (duration: 163.229135ms)","trace[567551702] 'compare'  (duration: 76.50165ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:28:53.587962Z","caller":"traceutil/trace.go:171","msg":"trace[450808860] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"210.963117ms","start":"2026-09-09T06:28:53.376981Z","end":"2026-09-09T06:28:53.587944Z","steps":["trace[450808860] 'process raft request'  (duration: 210.907394ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:28:53.588059Z","caller":"traceutil/trace.go:171","msg":"trace[1709828415] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"211.90442ms","start":"2026-09-09T06:28:53.376087Z","end":"2026-09-09T06:28:53.587992Z","steps":["trace[1709828415] 'process raft request'  (duration: 211.682194ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:28:53.588338Z","caller":"traceutil/trace.go:171","msg":"trace[958435518] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"212.215026ms","start":"2026-09-09T06:28:53.376105Z","end":"2026-09-09T06:28:53.58832Z","steps":["trace[958435518] 'process raft request'  (duration: 211.732224ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:28:53.588479Z","caller":"traceutil/trace.go:171","msg":"trace[775175268] linearizableReadLoop","detail":"{readStateIndex:5483; appliedIndex:5481; }","duration":"238.913316ms","start":"2026-09-09T06:28:53.349523Z","end":"2026-09-09T06:28:53.588437Z","steps":["trace[775175268] 'read index received'  (duration: 23.138314ms)","trace[775175268] 'applied index is now lower than readState.Index'  (duration: 215.773562ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:28:53.58873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.250876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:28:53.588803Z","caller":"traceutil/trace.go:171","msg":"trace[471326763] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5288; }","duration":"237.351058ms","start":"2026-09-09T06:28:53.351429Z","end":"2026-09-09T06:28:53.58878Z","steps":["trace[471326763] 'agreement among raft nodes before linearized reading'  (duration: 237.193964ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:28:53.588856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.480052ms","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-09T06:28:53.588916Z","caller":"traceutil/trace.go:171","msg":"trace[1876508046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5288; }","duration":"232.571965ms","start":"2026-09-09T06:28:53.356328Z","end":"2026-09-09T06:28:53.5889Z","steps":["trace[1876508046] 'agreement among raft nodes before linearized reading'  (duration: 232.40528ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:28:53.589185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.652204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-09-09T06:28:53.58924Z","caller":"traceutil/trace.go:171","msg":"trace[1842440269] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5288; }","duration":"239.724225ms","start":"2026-09-09T06:28:53.349501Z","end":"2026-09-09T06:28:53.589225Z","steps":["trace[1842440269] 'agreement among raft nodes before linearized reading'  (duration: 239.623043ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:28:54.594066Z","caller":"traceutil/trace.go:171","msg":"trace[73497574] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"213.689212ms","start":"2026-09-09T06:28:54.38035Z","end":"2026-09-09T06:28:54.59404Z","steps":["trace[73497574] 'process raft request'  (duration: 213.356705ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:28:54.594946Z","caller":"traceutil/trace.go:171","msg":"trace[207094743] linearizableReadLoop","detail":"{readStateIndex:5545; appliedIndex:5543; }","duration":"157.61158ms","start":"2026-09-09T06:28:54.43732Z","end":"2026-09-09T06:28:54.594932Z","steps":["trace[207094743] 'read index received'  (duration: 156.409202ms)","trace[207094743] 'applied index is now lower than readState.Index'  (duration: 1.201328ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:28:54.595033Z","caller":"traceutil/trace.go:171","msg":"trace[1354945050] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"162.348383ms","start":"2026-09-09T06:28:54.432673Z","end":"2026-09-09T06:28:54.595021Z","steps":["trace[1354945050] 'process raft request'  (duration: 162.17456ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:28:54.595245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.623776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-09T06:28:54.5953Z","caller":"traceutil/trace.go:171","msg":"trace[1286105035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5346; }","duration":"156.72883ms","start":"2026-09-09T06:28:54.438558Z","end":"2026-09-09T06:28:54.595287Z","steps":["trace[1286105035] 'agreement among raft nodes before linearized reading'  (duration: 156.569885ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:28:54.595502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.182054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-09T06:28:54.595558Z","caller":"traceutil/trace.go:171","msg":"trace[363579123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5346; }","duration":"158.241195ms","start":"2026-09-09T06:28:54.437306Z","end":"2026-09-09T06:28:54.595548Z","steps":["trace[363579123] 'agreement among raft nodes before linearized reading'  (duration: 158.060981ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:28:55.986958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.546043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:28:55.987042Z","caller":"traceutil/trace.go:171","msg":"trace[258283947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5373; }","duration":"158.682206ms","start":"2026-09-09T06:28:55.828342Z","end":"2026-09-09T06:28:55.987024Z","steps":["trace[258283947] 'count revisions from in-memory index tree'  (duration: 158.427211ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:29:10.578508Z","caller":"traceutil/trace.go:171","msg":"trace[991039983] transaction","detail":"{read_only:false; response_revision:5639; number_of_response:1; }","duration":"148.147404ms","start":"2026-09-09T06:29:10.430299Z","end":"2026-09-09T06:29:10.578423Z","steps":["trace[991039983] 'process raft request'  (duration: 133.500694ms)","trace[991039983] 'compare'  (duration: 14.352283ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:29:10.57899Z","caller":"traceutil/trace.go:171","msg":"trace[1547509096] transaction","detail":"{read_only:false; response_revision:5640; number_of_response:1; }","duration":"147.993289ms","start":"2026-09-09T06:29:10.430973Z","end":"2026-09-09T06:29:10.578966Z","steps":["trace[1547509096] 'process raft request'  (duration: 147.351095ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:29:10.579057Z","caller":"traceutil/trace.go:171","msg":"trace[792935888] linearizableReadLoop","detail":"{readStateIndex:5849; appliedIndex:5845; }","duration":"145.246734ms","start":"2026-09-09T06:29:10.43379Z","end":"2026-09-09T06:29:10.579036Z","steps":["trace[792935888] 'read index received'  (duration: 34.197977ms)","trace[792935888] 'applied index is now lower than readState.Index'  (duration: 111.047097ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:29:10.579401Z","caller":"traceutil/trace.go:171","msg":"trace[909817678] transaction","detail":"{read_only:false; response_revision:5641; number_of_response:1; }","duration":"144.410155ms","start":"2026-09-09T06:29:10.434969Z","end":"2026-09-09T06:29:10.57938Z","steps":["trace[909817678] 'process raft request'  (duration: 143.782859ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:29:10.579644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.835858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-tvcj8\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-09-09T06:29:10.579696Z","caller":"traceutil/trace.go:171","msg":"trace[456556382] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-tvcj8; range_end:; response_count:1; response_revision:5641; }","duration":"145.91632ms","start":"2026-09-09T06:29:10.433765Z","end":"2026-09-09T06:29:10.579681Z","steps":["trace[456556382] 'agreement among raft nodes before linearized reading'  (duration: 145.754806ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:29:11.036095Z","caller":"traceutil/trace.go:171","msg":"trace[1246380884] transaction","detail":"{read_only:false; response_revision:5650; number_of_response:1; }","duration":"245.902713ms","start":"2026-09-09T06:29:10.790144Z","end":"2026-09-09T06:29:11.036047Z","steps":["trace[1246380884] 'process raft request'  (duration: 245.720359ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:29:11.065386Z","caller":"traceutil/trace.go:171","msg":"trace[573661443] transaction","detail":"{read_only:false; response_revision:5651; number_of_response:1; }","duration":"273.38608ms","start":"2026-09-09T06:29:10.791971Z","end":"2026-09-09T06:29:11.065357Z","steps":["trace[573661443] 'process raft request'  (duration: 273.225786ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:29:19.378329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.928642ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9422551337711526704 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5723 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T06:29:19.378439Z","caller":"traceutil/trace.go:171","msg":"trace[1781143950] linearizableReadLoop","detail":"{readStateIndex:6001; appliedIndex:6000; }","duration":"246.538228ms","start":"2026-09-09T06:29:19.131883Z","end":"2026-09-09T06:29:19.378421Z","steps":["trace[1781143950] 'read index received'  (duration: 44.271069ms)","trace[1781143950] 'applied index is now lower than readState.Index'  (duration: 202.265959ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:29:19.378534Z","caller":"traceutil/trace.go:171","msg":"trace[1689390148] transaction","detail":"{read_only:false; response_revision:5790; number_of_response:1; }","duration":"278.063432ms","start":"2026-09-09T06:29:19.10045Z","end":"2026-09-09T06:29:19.378513Z","steps":["trace[1689390148] 'process raft request'  (duration: 105.859192ms)","trace[1689390148] 'compare'  (duration: 171.693407ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:29:19.378568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.697291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:29:19.378593Z","caller":"traceutil/trace.go:171","msg":"trace[767219875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5790; }","duration":"246.764974ms","start":"2026-09-09T06:29:19.131819Z","end":"2026-09-09T06:29:19.378584Z","steps":["trace[767219875] 'agreement among raft nodes before linearized reading'  (duration: 246.717493ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:29:19.379148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.440387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-09T06:29:19.379189Z","caller":"traceutil/trace.go:171","msg":"trace[1216692756] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5790; }","duration":"160.53848ms","start":"2026-09-09T06:29:19.218642Z","end":"2026-09-09T06:29:19.37918Z","steps":["trace[1216692756] 'agreement among raft nodes before linearized reading'  (duration: 160.142701ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:29:19.62787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.315095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4a835687-72c7-4ce5-97a1-525f3d673c30\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-09-09T06:29:19.627974Z","caller":"traceutil/trace.go:171","msg":"trace[300509025] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4a835687-72c7-4ce5-97a1-525f3d673c30; range_end:; response_count:1; response_revision:5790; }","duration":"144.441208ms","start":"2026-09-09T06:29:19.48351Z","end":"2026-09-09T06:29:19.627951Z","steps":["trace[300509025] 'range keys from in-memory index tree'  (duration: 144.06517ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:29:22.618422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3010}
{"level":"info","ts":"2026-09-09T06:29:22.716487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3010,"took":"96.567795ms","hash":3504568362,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":29908992,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T06:29:22.716586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3504568362,"revision":3010,"compact-revision":-1}
{"level":"info","ts":"2026-09-09T06:29:30.786165Z","caller":"traceutil/trace.go:171","msg":"trace[832553576] transaction","detail":"{read_only:false; response_revision:5972; number_of_response:1; }","duration":"112.616222ms","start":"2026-09-09T06:29:30.673511Z","end":"2026-09-09T06:29:30.786106Z","steps":["trace[832553576] 'process raft request'  (duration: 99.560478ms)","trace[832553576] 'compare'  (duration: 12.786938ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:30:12.434817Z","caller":"traceutil/trace.go:171","msg":"trace[879086023] transaction","detail":"{read_only:false; response_revision:6340; number_of_response:1; }","duration":"121.144047ms","start":"2026-09-09T06:30:12.313649Z","end":"2026-09-09T06:30:12.434793Z","steps":["trace[879086023] 'process raft request'  (duration: 120.953423ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:34:22.625449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5877}
{"level":"info","ts":"2026-09-09T06:34:22.739986Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5877,"took":"112.693419ms","hash":730778737,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":26963968,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-09T06:34:22.740086Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":730778737,"revision":5877,"compact-revision":3010}
{"level":"warn","ts":"2026-09-09T06:35:25.320966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.870038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:35:25.321075Z","caller":"traceutil/trace.go:171","msg":"trace[8995867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8656; }","duration":"189.034403ms","start":"2026-09-09T06:35:25.132016Z","end":"2026-09-09T06:35:25.321051Z","steps":["trace[8995867] 'range keys from in-memory index tree'  (duration: 188.798406ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:35:37.167493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.160571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-09T06:35:37.167589Z","caller":"traceutil/trace.go:171","msg":"trace[1448301212] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8717; }","duration":"246.343355ms","start":"2026-09-09T06:35:36.921222Z","end":"2026-09-09T06:35:37.167566Z","steps":["trace[1448301212] 'range keys from in-memory index tree'  (duration: 245.926295ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:35:37.167493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.377578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-09T06:35:37.167841Z","caller":"traceutil/trace.go:171","msg":"trace[1713410445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8717; }","duration":"261.598993ms","start":"2026-09-09T06:35:36.90607Z","end":"2026-09-09T06:35:37.167669Z","steps":["trace[1713410445] 'range keys from in-memory index tree'  (duration: 261.202354ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:35:38.008537Z","caller":"traceutil/trace.go:171","msg":"trace[1786432585] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"273.578262ms","start":"2026-09-09T06:35:37.734899Z","end":"2026-09-09T06:35:38.008477Z","steps":["trace[1786432585] 'process raft request'  (duration: 273.370317ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:35:38.008725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.832229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-09-09T06:35:38.008783Z","caller":"traceutil/trace.go:171","msg":"trace[271530415] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8720; }","duration":"152.957052ms","start":"2026-09-09T06:35:37.855813Z","end":"2026-09-09T06:35:38.00877Z","steps":["trace[271530415] 'agreement among raft nodes before linearized reading'  (duration: 152.766647ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:35:38.008445Z","caller":"traceutil/trace.go:171","msg":"trace[654817190] linearizableReadLoop","detail":"{readStateIndex:9027; appliedIndex:9026; }","duration":"152.559532ms","start":"2026-09-09T06:35:37.855863Z","end":"2026-09-09T06:35:38.008422Z","steps":["trace[654817190] 'read index received'  (duration: 152.347737ms)","trace[654817190] 'applied index is now lower than readState.Index'  (duration: 210.675µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:35:38.1198Z","caller":"traceutil/trace.go:171","msg":"trace[963720650] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"104.666135ms","start":"2026-09-09T06:35:38.015106Z","end":"2026-09-09T06:35:38.119772Z","steps":["trace[963720650] 'process raft request'  (duration: 104.513322ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:35:38.617591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.883126ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9422551337711534559 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8715 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T06:35:38.617814Z","caller":"traceutil/trace.go:171","msg":"trace[2131236917] linearizableReadLoop","detail":"{readStateIndex:9033; appliedIndex:9031; }","duration":"198.768667ms","start":"2026-09-09T06:35:38.419025Z","end":"2026-09-09T06:35:38.617794Z","steps":["trace[2131236917] 'read index received'  (duration: 141.609278ms)","trace[2131236917] 'applied index is now lower than readState.Index'  (duration: 57.158169ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:35:38.617915Z","caller":"traceutil/trace.go:171","msg":"trace[786636961] transaction","detail":"{read_only:false; response_revision:8725; number_of_response:1; }","duration":"267.104485ms","start":"2026-09-09T06:35:38.350778Z","end":"2026-09-09T06:35:38.617883Z","steps":["trace[786636961] 'process raft request'  (duration: 12.790429ms)","trace[786636961] 'compare'  (duration: 253.556778ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:35:38.617972Z","caller":"traceutil/trace.go:171","msg":"trace[1562520547] transaction","detail":"{read_only:false; response_revision:8726; number_of_response:1; }","duration":"207.707732ms","start":"2026-09-09T06:35:38.410201Z","end":"2026-09-09T06:35:38.617909Z","steps":["trace[1562520547] 'process raft request'  (duration: 207.520268ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:35:38.618017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.997052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bg7nn\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-09-09T06:35:38.618072Z","caller":"traceutil/trace.go:171","msg":"trace[1656956704] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bg7nn; range_end:; response_count:1; response_revision:8726; }","duration":"199.104564ms","start":"2026-09-09T06:35:38.418953Z","end":"2026-09-09T06:35:38.618058Z","steps":["trace[1656956704] 'agreement among raft nodes before linearized reading'  (duration: 198.89247ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:35:38.945343Z","caller":"traceutil/trace.go:171","msg":"trace[631843137] linearizableReadLoop","detail":"{readStateIndex:9034; appliedIndex:9033; }","duration":"144.026886ms","start":"2026-09-09T06:35:38.801227Z","end":"2026-09-09T06:35:38.945254Z","steps":["trace[631843137] 'read index received'  (duration: 66.780202ms)","trace[631843137] 'applied index is now lower than readState.Index'  (duration: 77.244824ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:35:38.94565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.374014ms","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:5"}
{"level":"info","ts":"2026-09-09T06:35:38.945705Z","caller":"traceutil/trace.go:171","msg":"trace[312198812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8727; }","duration":"144.525107ms","start":"2026-09-09T06:35:38.801167Z","end":"2026-09-09T06:35:38.945692Z","steps":["trace[312198812] 'agreement among raft nodes before linearized reading'  (duration: 144.321323ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:35:38.945694Z","caller":"traceutil/trace.go:171","msg":"trace[642539112] transaction","detail":"{read_only:false; response_revision:8727; number_of_response:1; }","duration":"285.371406ms","start":"2026-09-09T06:35:38.660278Z","end":"2026-09-09T06:35:38.94565Z","steps":["trace[642539112] 'process raft request'  (duration: 207.712382ms)","trace[642539112] 'compare'  (duration: 77.02478ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:35:38.950249Z","caller":"traceutil/trace.go:171","msg":"trace[73286973] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"117.100356ms","start":"2026-09-09T06:35:38.833134Z","end":"2026-09-09T06:35:38.950235Z","steps":["trace[73286973] 'process raft request'  (duration: 117.006554ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:35:40.882648Z","caller":"traceutil/trace.go:171","msg":"trace[1630985996] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"211.024552ms","start":"2026-09-09T06:35:40.67159Z","end":"2026-09-09T06:35:40.882615Z","steps":["trace[1630985996] 'process raft request'  (duration: 120.9926ms)","trace[1630985996] 'compare'  (duration: 89.759796ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:35:40.882665Z","caller":"traceutil/trace.go:171","msg":"trace[229222650] linearizableReadLoop","detail":"{readStateIndex:9046; appliedIndex:9045; }","duration":"133.476151ms","start":"2026-09-09T06:35:40.749167Z","end":"2026-09-09T06:35:40.882643Z","steps":["trace[229222650] 'read index received'  (duration: 43.435839ms)","trace[229222650] 'applied index is now lower than readState.Index'  (duration: 90.037932ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:35:40.88293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.712787ms","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-09T06:35:40.88298Z","caller":"traceutil/trace.go:171","msg":"trace[1411377850] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8740; }","duration":"133.868861ms","start":"2026-09-09T06:35:40.749097Z","end":"2026-09-09T06:35:40.882966Z","steps":["trace[1411377850] 'agreement among raft nodes before linearized reading'  (duration: 133.606315ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:36:03.673708Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002405.wal"}
{"level":"info","ts":"2026-09-09T06:36:04.541544Z","caller":"traceutil/trace.go:171","msg":"trace[1201015046] transaction","detail":"{read_only:false; response_revision:8915; number_of_response:1; }","duration":"102.248783ms","start":"2026-09-09T06:36:04.439266Z","end":"2026-09-09T06:36:04.541514Z","steps":["trace[1201015046] 'process raft request'  (duration: 100.93705ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:36:06.923763Z","caller":"traceutil/trace.go:171","msg":"trace[871518538] linearizableReadLoop","detail":"{readStateIndex:9246; appliedIndex:9245; }","duration":"101.825992ms","start":"2026-09-09T06:36:06.821913Z","end":"2026-09-09T06:36:06.923739Z","steps":["trace[871518538] 'read index received'  (duration: 101.502983ms)","trace[871518538] 'applied index is now lower than readState.Index'  (duration: 321.859µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:36:06.923954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.027807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bg7nn\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-09-09T06:36:06.923982Z","caller":"traceutil/trace.go:171","msg":"trace[581790996] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bg7nn; range_end:; response_count:1; response_revision:8931; }","duration":"102.113729ms","start":"2026-09-09T06:36:06.821859Z","end":"2026-09-09T06:36:06.923973Z","steps":["trace[581790996] 'agreement among raft nodes before linearized reading'  (duration: 101.976006ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:36:06.923962Z","caller":"traceutil/trace.go:171","msg":"trace[249797665] transaction","detail":"{read_only:false; response_revision:8931; number_of_response:1; }","duration":"155.564643ms","start":"2026-09-09T06:36:06.768374Z","end":"2026-09-09T06:36:06.923939Z","steps":["trace[249797665] 'process raft request'  (duration: 155.169223ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:36:07.362681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.89384ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9422551337711535217 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8919 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T06:36:07.362784Z","caller":"traceutil/trace.go:171","msg":"trace[1525084473] transaction","detail":"{read_only:false; response_revision:8932; number_of_response:1; }","duration":"289.750626ms","start":"2026-09-09T06:36:07.073014Z","end":"2026-09-09T06:36:07.362765Z","steps":["trace[1525084473] 'process raft request'  (duration: 64.689142ms)","trace[1525084473] 'compare'  (duration: 224.582472ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:36:07.382998Z","caller":"traceutil/trace.go:171","msg":"trace[741857513] transaction","detail":"{read_only:false; response_revision:8933; number_of_response:1; }","duration":"309.851934ms","start":"2026-09-09T06:36:07.073118Z","end":"2026-09-09T06:36:07.382969Z","steps":["trace[741857513] 'process raft request'  (duration: 309.71225ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:36:07.383184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:36:07.073089Z","time spent":"309.992838ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8920 > 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":"info","ts":"2026-09-09T06:36:15.830335Z","caller":"traceutil/trace.go:171","msg":"trace[1616173514] transaction","detail":"{read_only:false; response_revision:8977; number_of_response:1; }","duration":"102.015647ms","start":"2026-09-09T06:36:15.728289Z","end":"2026-09-09T06:36:15.830305Z","steps":["trace[1616173514] 'process raft request'  (duration: 101.821813ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:36:21.697601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.86852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-09T06:36:21.697651Z","caller":"traceutil/trace.go:171","msg":"trace[456838434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9050; }","duration":"111.970493ms","start":"2026-09-09T06:36:21.58567Z","end":"2026-09-09T06:36:21.69764Z","steps":["trace[456838434] 'range keys from in-memory index tree'  (duration: 111.692156ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:36:21.739347Z","caller":"traceutil/trace.go:171","msg":"trace[1174134577] linearizableReadLoop","detail":"{readStateIndex:9370; appliedIndex:9369; }","duration":"107.784269ms","start":"2026-09-09T06:36:21.631555Z","end":"2026-09-09T06:36:21.739339Z","steps":["trace[1174134577] 'read index received'  (duration: 48.87206ms)","trace[1174134577] 'applied index is now lower than readState.Index'  (duration: 58.911629ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:36:21.739972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.412215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"}
{"level":"info","ts":"2026-09-09T06:36:21.739994Z","caller":"traceutil/trace.go:171","msg":"trace[1385108041] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:9051; }","duration":"108.469806ms","start":"2026-09-09T06:36:21.631518Z","end":"2026-09-09T06:36:21.739988Z","steps":["trace[1385108041] 'agreement among raft nodes before linearized reading'  (duration: 107.855971ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:37:23.340333Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"596257f6524f82c3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-09T06:37:23.347246Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-09T06:37:23.347347Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-09T06:37:32.739952Z","caller":"traceutil/trace.go:171","msg":"trace[1271911413] transaction","detail":"{read_only:false; response_revision:9763; number_of_response:1; }","duration":"112.487951ms","start":"2026-09-09T06:37:32.627436Z","end":"2026-09-09T06:37:32.739924Z","steps":["trace[1271911413] 'process raft request'  (duration: 112.331408ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:37:45.899673Z","caller":"traceutil/trace.go:171","msg":"trace[42961413] transaction","detail":"{read_only:false; response_revision:9837; number_of_response:1; }","duration":"103.388533ms","start":"2026-09-09T06:37:45.796262Z","end":"2026-09-09T06:37:45.899651Z","steps":["trace[42961413] 'process raft request'  (duration: 103.210899ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:39:22.632898Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8095}
{"level":"info","ts":"2026-09-09T06:39:22.722056Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8095,"took":"86.046073ms","hash":3567651269,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":25624576,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-09T06:39:22.722167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3567651269,"revision":8095,"compact-revision":5877}
{"level":"info","ts":"2026-09-09T06:41:18.102423Z","caller":"traceutil/trace.go:171","msg":"trace[981497018] linearizableReadLoop","detail":"{readStateIndex:12012; appliedIndex:12011; }","duration":"122.786096ms","start":"2026-09-09T06:41:17.979603Z","end":"2026-09-09T06:41:18.102389Z","steps":["trace[981497018] 'read index received'  (duration: 94.422243ms)","trace[981497018] 'applied index is now lower than readState.Index'  (duration: 28.362453ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:41:18.102496Z","caller":"traceutil/trace.go:171","msg":"trace[1439744784] transaction","detail":"{read_only:false; response_revision:11620; number_of_response:1; }","duration":"131.814785ms","start":"2026-09-09T06:41:17.970626Z","end":"2026-09-09T06:41:18.102441Z","steps":["trace[1439744784] 'process raft request'  (duration: 103.377961ms)","trace[1439744784] 'compare'  (duration: 28.238719ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:41:18.10272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.092493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-09-09T06:41:18.102808Z","caller":"traceutil/trace.go:171","msg":"trace[1036017170] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11620; }","duration":"123.206265ms","start":"2026-09-09T06:41:17.979579Z","end":"2026-09-09T06:41:18.102785Z","steps":["trace[1036017170] 'agreement among raft nodes before linearized reading'  (duration: 122.955849ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:41:18.483153Z","caller":"traceutil/trace.go:171","msg":"trace[1284368372] transaction","detail":"{read_only:false; response_revision:11624; number_of_response:1; }","duration":"140.438526ms","start":"2026-09-09T06:41:18.342689Z","end":"2026-09-09T06:41:18.483128Z","steps":["trace[1284368372] 'process raft request'  (duration: 140.289633ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:44:22.64098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10517}
{"level":"info","ts":"2026-09-09T06:44:22.736721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10517,"took":"93.332343ms","hash":1938668076,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":27815936,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-09T06:44:22.736905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1938668076,"revision":10517,"compact-revision":8095}
{"level":"info","ts":"2026-09-09T06:47:42.13972Z","caller":"traceutil/trace.go:171","msg":"trace[931660271] transaction","detail":"{read_only:false; response_revision:14199; number_of_response:1; }","duration":"137.438444ms","start":"2026-09-09T06:47:42.002255Z","end":"2026-09-09T06:47:42.139694Z","steps":["trace[931660271] 'process raft request'  (duration: 137.268329ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:02.599401Z","caller":"traceutil/trace.go:171","msg":"trace[359430285] linearizableReadLoop","detail":"{readStateIndex:14789; appliedIndex:14788; }","duration":"244.738104ms","start":"2026-09-09T06:48:02.354633Z","end":"2026-09-09T06:48:02.599371Z","steps":["trace[359430285] 'read index received'  (duration: 244.543538ms)","trace[359430285] 'applied index is now lower than readState.Index'  (duration: 193.416µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:48:02.599467Z","caller":"traceutil/trace.go:171","msg":"trace[129151294] transaction","detail":"{read_only:false; response_revision:14302; number_of_response:1; }","duration":"315.817733ms","start":"2026-09-09T06:48:02.283592Z","end":"2026-09-09T06:48:02.599409Z","steps":["trace[129151294] 'process raft request'  (duration: 315.638627ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:02.599712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.541309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-09-09T06:48:02.599732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:02.283566Z","time spent":"316.059769ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14292 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-09T06:48:02.599783Z","caller":"traceutil/trace.go:171","msg":"trace[143262357] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14302; }","duration":"237.648481ms","start":"2026-09-09T06:48:02.362101Z","end":"2026-09-09T06:48:02.599749Z","steps":["trace[143262357] 'agreement among raft nodes before linearized reading'  (duration: 237.469697ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:02.599762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.923973ms","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-09T06:48:02.599795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.147984ms","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-09T06:48:02.599853Z","caller":"traceutil/trace.go:171","msg":"trace[1064166464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14302; }","duration":"244.062946ms","start":"2026-09-09T06:48:02.355766Z","end":"2026-09-09T06:48:02.599829Z","steps":["trace[1064166464] 'agreement among raft nodes before linearized reading'  (duration: 243.80721ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:02.599881Z","caller":"traceutil/trace.go:171","msg":"trace[850078292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14302; }","duration":"245.292007ms","start":"2026-09-09T06:48:02.35457Z","end":"2026-09-09T06:48:02.599862Z","steps":["trace[850078292] 'agreement among raft nodes before linearized reading'  (duration: 244.99559ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:12.105861Z","caller":"traceutil/trace.go:171","msg":"trace[159055154] transaction","detail":"{read_only:false; response_revision:14350; number_of_response:1; }","duration":"122.126101ms","start":"2026-09-09T06:48:11.983646Z","end":"2026-09-09T06:48:12.105772Z","steps":["trace[159055154] 'process raft request'  (duration: 121.859865ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:21.050596Z","caller":"traceutil/trace.go:171","msg":"trace[178443979] transaction","detail":"{read_only:false; response_revision:14408; number_of_response:1; }","duration":"388.350476ms","start":"2026-09-09T06:48:20.662222Z","end":"2026-09-09T06:48:21.050572Z","steps":["trace[178443979] 'process raft request'  (duration: 388.185962ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:21.050752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:20.662185Z","time spent":"388.48942ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:14319 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-09-09T06:48:21.051546Z","caller":"traceutil/trace.go:171","msg":"trace[854008767] linearizableReadLoop","detail":"{readStateIndex:14901; appliedIndex:14899; }","duration":"359.122004ms","start":"2026-09-09T06:48:20.692408Z","end":"2026-09-09T06:48:21.05153Z","steps":["trace[854008767] 'read index received'  (duration: 358.003917ms)","trace[854008767] 'applied index is now lower than readState.Index'  (duration: 1.117567ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:48:21.051849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.322487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-09-09T06:48:21.051827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.405383ms","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-09T06:48:21.051903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.677792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-09T06:48:21.051908Z","caller":"traceutil/trace.go:171","msg":"trace[80494026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14409; }","duration":"359.541376ms","start":"2026-09-09T06:48:20.692349Z","end":"2026-09-09T06:48:21.05189Z","steps":["trace[80494026] 'agreement among raft nodes before linearized reading'  (duration: 359.300839ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:21.051951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:20.692331Z","time spent":"359.610407ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-09T06:48:21.052002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.577921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-mvj8d\" ","response":"range_response_count:1 size:12364"}
{"level":"info","ts":"2026-09-09T06:48:21.052014Z","caller":"traceutil/trace.go:171","msg":"trace[1844321256] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-mvj8d; range_end:; response_count:1; response_revision:14409; }","duration":"277.632974ms","start":"2026-09-09T06:48:20.774378Z","end":"2026-09-09T06:48:21.052011Z","steps":["trace[1844321256] 'agreement among raft nodes before linearized reading'  (duration: 277.596043ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:21.051875Z","caller":"traceutil/trace.go:171","msg":"trace[1664503773] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14409; }","duration":"356.406769ms","start":"2026-09-09T06:48:20.69546Z","end":"2026-09-09T06:48:21.051866Z","steps":["trace[1664503773] 'agreement among raft nodes before linearized reading'  (duration: 356.304087ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:21.051922Z","caller":"traceutil/trace.go:171","msg":"trace[1603943438] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:14409; }","duration":"170.735673ms","start":"2026-09-09T06:48:20.881181Z","end":"2026-09-09T06:48:21.051917Z","steps":["trace[1603943438] 'agreement among raft nodes before linearized reading'  (duration: 170.706023ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:21.052161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.804172ms","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-09T06:48:21.052174Z","caller":"traceutil/trace.go:171","msg":"trace[360958783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14409; }","duration":"352.848383ms","start":"2026-09-09T06:48:20.699321Z","end":"2026-09-09T06:48:21.05217Z","steps":["trace[360958783] 'agreement among raft nodes before linearized reading'  (duration: 352.807132ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:21.052171Z","caller":"traceutil/trace.go:171","msg":"trace[816541198] transaction","detail":"{read_only:false; response_revision:14409; number_of_response:1; }","duration":"381.193282ms","start":"2026-09-09T06:48:20.670963Z","end":"2026-09-09T06:48:21.052156Z","steps":["trace[816541198] 'process raft request'  (duration: 380.460104ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:21.052186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:20.699291Z","time spent":"352.891114ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-09T06:48:21.052227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:20.670938Z","time spent":"381.255453ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14383 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-09T06:48:21.051965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.331394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bg7nn\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-09-09T06:48:21.052273Z","caller":"traceutil/trace.go:171","msg":"trace[1325235150] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bg7nn; range_end:; response_count:1; response_revision:14409; }","duration":"205.670742ms","start":"2026-09-09T06:48:20.846591Z","end":"2026-09-09T06:48:21.052262Z","steps":["trace[1325235150] 'agreement among raft nodes before linearized reading'  (duration: 205.340005ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:21.05212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:20.695448Z","time spent":"356.651856ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-09-09T06:48:44.372031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.381518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:48:44.372272Z","caller":"traceutil/trace.go:171","msg":"trace[224597359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14725; }","duration":"240.622173ms","start":"2026-09-09T06:48:44.131583Z","end":"2026-09-09T06:48:44.372205Z","steps":["trace[224597359] 'range keys from in-memory index tree'  (duration: 240.297975ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:44.372411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.792754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc7c03f9-212d-4e28-9c19-c37cd339a7a6\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-09-09T06:48:44.372563Z","caller":"traceutil/trace.go:171","msg":"trace[1165551498] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc7c03f9-212d-4e28-9c19-c37cd339a7a6; range_end:; response_count:1; response_revision:14725; }","duration":"355.999959ms","start":"2026-09-09T06:48:44.016539Z","end":"2026-09-09T06:48:44.372539Z","steps":["trace[1165551498] 'range keys from in-memory index tree'  (duration: 355.61719ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:44.37262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:44.016517Z","time spent":"356.090141ms","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3659,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc7c03f9-212d-4e28-9c19-c37cd339a7a6\" "}
{"level":"warn","ts":"2026-09-09T06:48:44.372681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.144196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-09-09T06:48:44.372681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.921607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc7c03f9-212d-4e28-9c19-c37cd339a7a6\" ","response":"range_response_count:1 size:3637"}
{"level":"warn","ts":"2026-09-09T06:48:44.372672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.836905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:48:44.372751Z","caller":"traceutil/trace.go:171","msg":"trace[631985101] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc7c03f9-212d-4e28-9c19-c37cd339a7a6; range_end:; response_count:1; response_revision:14725; }","duration":"266.03999ms","start":"2026-09-09T06:48:44.106695Z","end":"2026-09-09T06:48:44.372735Z","steps":["trace[631985101] 'range keys from in-memory index tree'  (duration: 265.728493ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:44.372734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:43.971703Z","time spent":"401.015894ms","remote":"127.0.0.1:37064","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-09-09T06:48:44.372745Z","caller":"traceutil/trace.go:171","msg":"trace[916865226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14725; }","duration":"100.267308ms","start":"2026-09-09T06:48:44.27246Z","end":"2026-09-09T06:48:44.372727Z","steps":["trace[916865226] 'range keys from in-memory index tree'  (duration: 99.91571ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:48:44.373738Z","caller":"traceutil/trace.go:171","msg":"trace[163231855] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14725; }","duration":"407.059251ms","start":"2026-09-09T06:48:43.965722Z","end":"2026-09-09T06:48:44.372781Z","steps":["trace[163231855] 'range keys from in-memory index tree'  (duration: 406.730052ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:48:44.373829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:48:43.965696Z","time spent":"408.117177ms","remote":"127.0.0.1:50576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-09-09T06:49:22.645671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12827}
{"level":"info","ts":"2026-09-09T06:49:22.716879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12827,"took":"68.933482ms","hash":2326799847,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":30244864,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T06:49:22.716929Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2326799847,"revision":12827,"compact-revision":10517}
{"level":"info","ts":"2026-09-09T06:50:16.324621Z","caller":"traceutil/trace.go:171","msg":"trace[1439350232] transaction","detail":"{read_only:false; response_revision:15566; number_of_response:1; }","duration":"103.36027ms","start":"2026-09-09T06:50:16.221199Z","end":"2026-09-09T06:50:16.324559Z","steps":["trace[1439350232] 'process raft request'  (duration: 103.104834ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:50:16.509953Z","caller":"traceutil/trace.go:171","msg":"trace[2100533559] linearizableReadLoop","detail":"{readStateIndex:16097; appliedIndex:16096; }","duration":"181.359123ms","start":"2026-09-09T06:50:16.328568Z","end":"2026-09-09T06:50:16.509927Z","steps":["trace[2100533559] 'read index received'  (duration: 178.246196ms)","trace[2100533559] 'applied index is now lower than readState.Index'  (duration: 3.111287ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:50:16.510265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.67855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-09T06:50:16.51031Z","caller":"traceutil/trace.go:171","msg":"trace[704918007] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:15566; }","duration":"181.756643ms","start":"2026-09-09T06:50:16.328541Z","end":"2026-09-09T06:50:16.510298Z","steps":["trace[704918007] 'agreement among raft nodes before linearized reading'  (duration: 181.666861ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:50:16.605995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.047204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"warn","ts":"2026-09-09T06:50:16.606032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.931298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-09-09T06:50:16.606074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.796055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"}
{"level":"info","ts":"2026-09-09T06:50:16.606114Z","caller":"traceutil/trace.go:171","msg":"trace[570211590] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15567; }","duration":"135.220818ms","start":"2026-09-09T06:50:16.470871Z","end":"2026-09-09T06:50:16.606092Z","steps":["trace[570211590] 'agreement among raft nodes before linearized reading'  (duration: 134.91181ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:50:16.606114Z","caller":"traceutil/trace.go:171","msg":"trace[1314736087] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15567; }","duration":"132.043431ms","start":"2026-09-09T06:50:16.474057Z","end":"2026-09-09T06:50:16.6061Z","steps":["trace[1314736087] 'agreement among raft nodes before linearized reading'  (duration: 131.862957ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:50:16.606131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.526284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T06:50:16.606226Z","caller":"traceutil/trace.go:171","msg":"trace[657300802] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15567; }","duration":"137.666188ms","start":"2026-09-09T06:50:16.468539Z","end":"2026-09-09T06:50:16.606205Z","steps":["trace[657300802] 'agreement among raft nodes before linearized reading'  (duration: 137.497604ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:50:16.606268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.243806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-09-09T06:50:16.606303Z","caller":"traceutil/trace.go:171","msg":"trace[868502384] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15567; }","duration":"139.316438ms","start":"2026-09-09T06:50:16.466978Z","end":"2026-09-09T06:50:16.606295Z","steps":["trace[868502384] 'agreement among raft nodes before linearized reading'  (duration: 139.224326ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:50:16.606164Z","caller":"traceutil/trace.go:171","msg":"trace[1184714125] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15567; }","duration":"138.936288ms","start":"2026-09-09T06:50:16.46721Z","end":"2026-09-09T06:50:16.606146Z","steps":["trace[1184714125] 'agreement among raft nodes before linearized reading'  (duration: 138.686313ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:50:16.606383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.161128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-09-09T06:50:16.606592Z","caller":"traceutil/trace.go:171","msg":"trace[432439299] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15567; }","duration":"133.409843ms","start":"2026-09-09T06:50:16.473167Z","end":"2026-09-09T06:50:16.606577Z","steps":["trace[432439299] 'agreement among raft nodes before linearized reading'  (duration: 132.8194ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:50:16.606619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.490384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737337"}
{"level":"info","ts":"2026-09-09T06:50:16.606698Z","caller":"traceutil/trace.go:171","msg":"trace[1639147489] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15567; }","duration":"276.630277ms","start":"2026-09-09T06:50:16.330048Z","end":"2026-09-09T06:50:16.606679Z","steps":["trace[1639147489] 'agreement among raft nodes before linearized reading'  (duration: 275.705044ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:50:16.606505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.011728ms","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-09T06:50:16.606971Z","caller":"traceutil/trace.go:171","msg":"trace[1102778358] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15567; }","duration":"143.322906ms","start":"2026-09-09T06:50:16.463421Z","end":"2026-09-09T06:50:16.606743Z","steps":["trace[1102778358] 'agreement among raft nodes before linearized reading'  (duration: 142.982377ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:50:16.60588Z","caller":"traceutil/trace.go:171","msg":"trace[821393811] transaction","detail":"{read_only:false; response_revision:15567; number_of_response:1; }","duration":"276.121615ms","start":"2026-09-09T06:50:16.32971Z","end":"2026-09-09T06:50:16.605832Z","steps":["trace[821393811] 'process raft request'  (duration: 275.907929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:54:22.652997Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15188}
{"level":"info","ts":"2026-09-09T06:54:22.75587Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15188,"took":"99.176541ms","hash":2751698313,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":31416320,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-09T06:54:22.755944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2751698313,"revision":15188,"compact-revision":12827}
{"level":"info","ts":"2026-09-09T06:55:55.721414Z","caller":"traceutil/trace.go:171","msg":"trace[639617456] transaction","detail":"{read_only:false; response_revision:18110; number_of_response:1; }","duration":"161.145388ms","start":"2026-09-09T06:55:55.560243Z","end":"2026-09-09T06:55:55.721388Z","steps":["trace[639617456] 'process raft request'  (duration: 160.956214ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:55:56.246313Z","caller":"traceutil/trace.go:171","msg":"trace[1226833695] linearizableReadLoop","detail":"{readStateIndex:18727; appliedIndex:18726; }","duration":"229.241391ms","start":"2026-09-09T06:55:56.017025Z","end":"2026-09-09T06:55:56.246266Z","steps":["trace[1226833695] 'read index received'  (duration: 162.609122ms)","trace[1226833695] 'applied index is now lower than readState.Index'  (duration: 66.631099ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T06:55:56.246435Z","caller":"traceutil/trace.go:171","msg":"trace[1165090322] transaction","detail":"{read_only:false; response_revision:18114; number_of_response:1; }","duration":"180.385379ms","start":"2026-09-09T06:55:56.066037Z","end":"2026-09-09T06:55:56.246422Z","steps":["trace[1165090322] 'process raft request'  (duration: 180.171824ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:55:56.246323Z","caller":"traceutil/trace.go:171","msg":"trace[799475167] transaction","detail":"{read_only:false; response_revision:18113; number_of_response:1; }","duration":"267.713615ms","start":"2026-09-09T06:55:55.978557Z","end":"2026-09-09T06:55:56.24627Z","steps":["trace[799475167] 'process raft request'  (duration: 200.998284ms)","trace[799475167] 'compare'  (duration: 66.474835ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T06:55:56.246569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.975479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-09T06:55:56.246625Z","caller":"traceutil/trace.go:171","msg":"trace[1822658500] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18114; }","duration":"115.061222ms","start":"2026-09-09T06:55:56.131545Z","end":"2026-09-09T06:55:56.246606Z","steps":["trace[1822658500] 'agreement among raft nodes before linearized reading'  (duration: 114.935148ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:55:56.246717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.683542ms","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-09T06:55:56.246753Z","caller":"traceutil/trace.go:171","msg":"trace[563125350] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18114; }","duration":"229.742724ms","start":"2026-09-09T06:55:56.016997Z","end":"2026-09-09T06:55:56.24674Z","steps":["trace[563125350] 'agreement among raft nodes before linearized reading'  (duration: 229.365724ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:55:56.827441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.934531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-09T06:55:56.82758Z","caller":"traceutil/trace.go:171","msg":"trace[1319536537] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18116; }","duration":"383.138216ms","start":"2026-09-09T06:55:56.444413Z","end":"2026-09-09T06:55:56.827552Z","steps":["trace[1319536537] 'range keys from in-memory index tree'  (duration: 382.689003ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:55:56.827649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:55:56.444385Z","time spent":"383.248148ms","remote":"127.0.0.1:50404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-09T06:55:56.827842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.088471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-09T06:55:56.827928Z","caller":"traceutil/trace.go:171","msg":"trace[1947270861] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:18116; }","duration":"310.271186ms","start":"2026-09-09T06:55:56.51764Z","end":"2026-09-09T06:55:56.827911Z","steps":["trace[1947270861] 'count revisions from in-memory index tree'  (duration: 309.994889ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T06:55:56.827976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:55:56.517608Z","time spent":"310.354818ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":18,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"warn","ts":"2026-09-09T06:55:56.828371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.316168ms","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-09T06:55:56.82841Z","caller":"traceutil/trace.go:171","msg":"trace[1390590695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18116; }","duration":"265.380469ms","start":"2026-09-09T06:55:56.56302Z","end":"2026-09-09T06:55:56.8284Z","steps":["trace[1390590695] 'range keys from in-memory index tree'  (duration: 265.190634ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:55:57.020962Z","caller":"traceutil/trace.go:171","msg":"trace[1855365691] transaction","detail":"{read_only:false; response_revision:18120; number_of_response:1; }","duration":"106.446005ms","start":"2026-09-09T06:55:56.914484Z","end":"2026-09-09T06:55:57.02093Z","steps":["trace[1855365691] 'process raft request'  (duration: 106.23137ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T06:58:14.490059Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"596257f6524f82c3","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-09T06:58:14.514937Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-09T06:58:14.515183Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-09T06:59:22.662981Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17462}
{"level":"info","ts":"2026-09-09T06:59:22.769771Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17462,"took":"102.996488ms","hash":3627387394,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":34902016,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-09-09T06:59:22.769854Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3627387394,"revision":17462,"compact-revision":15188}
{"level":"info","ts":"2026-09-09T07:01:15.409934Z","caller":"traceutil/trace.go:171","msg":"trace[276993819] transaction","detail":"{read_only:false; response_revision:20712; number_of_response:1; }","duration":"133.413331ms","start":"2026-09-09T07:01:15.276497Z","end":"2026-09-09T07:01:15.40991Z","steps":["trace[276993819] 'process raft request'  (duration: 133.122935ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:01:55.719258Z","caller":"traceutil/trace.go:171","msg":"trace[2068560746] transaction","detail":"{read_only:false; response_revision:20918; number_of_response:1; }","duration":"105.679089ms","start":"2026-09-09T07:01:55.613557Z","end":"2026-09-09T07:01:55.719236Z","steps":["trace[2068560746] 'process raft request'  (duration: 105.526716ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:01:55.900638Z","caller":"traceutil/trace.go:171","msg":"trace[170493453] transaction","detail":"{read_only:false; response_revision:20919; number_of_response:1; }","duration":"285.591635ms","start":"2026-09-09T07:01:55.614982Z","end":"2026-09-09T07:01:55.900574Z","steps":["trace[170493453] 'process raft request'  (duration: 285.280078ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:01:55.919095Z","caller":"traceutil/trace.go:171","msg":"trace[766180317] linearizableReadLoop","detail":"{readStateIndex:21627; appliedIndex:21624; }","duration":"139.891158ms","start":"2026-09-09T07:01:55.779165Z","end":"2026-09-09T07:01:55.919056Z","steps":["trace[766180317] 'read index received'  (duration: 121.356399ms)","trace[766180317] 'applied index is now lower than readState.Index'  (duration: 18.533519ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T07:01:55.919354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.184566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-09-09T07:01:55.919434Z","caller":"traceutil/trace.go:171","msg":"trace[563658068] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20921; }","duration":"140.312559ms","start":"2026-09-09T07:01:55.779102Z","end":"2026-09-09T07:01:55.919415Z","steps":["trace[563658068] 'agreement among raft nodes before linearized reading'  (duration: 140.076092ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:01:55.919444Z","caller":"traceutil/trace.go:171","msg":"trace[1653385016] transaction","detail":"{read_only:false; response_revision:20920; number_of_response:1; }","duration":"176.736891ms","start":"2026-09-09T07:01:55.742675Z","end":"2026-09-09T07:01:55.919412Z","steps":["trace[1653385016] 'process raft request'  (duration: 176.187007ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:01:55.919519Z","caller":"traceutil/trace.go:171","msg":"trace[380073959] transaction","detail":"{read_only:false; response_revision:20921; number_of_response:1; }","duration":"163.293024ms","start":"2026-09-09T07:01:55.756153Z","end":"2026-09-09T07:01:55.919446Z","steps":["trace[380073959] 'process raft request'  (duration: 162.841133ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T07:02:12.212821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.943598ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9422551337711572848 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20991 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-09T07:02:12.213017Z","caller":"traceutil/trace.go:171","msg":"trace[1292698084] transaction","detail":"{read_only:false; response_revision:21001; number_of_response:1; }","duration":"220.234194ms","start":"2026-09-09T07:02:11.992758Z","end":"2026-09-09T07:02:12.212993Z","steps":["trace[1292698084] 'process raft request'  (duration: 73.01462ms)","trace[1292698084] 'compare'  (duration: 146.799634ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T07:02:12.214312Z","caller":"traceutil/trace.go:171","msg":"trace[1391814673] linearizableReadLoop","detail":"{readStateIndex:21712; appliedIndex:21710; }","duration":"215.113561ms","start":"2026-09-09T07:02:11.999155Z","end":"2026-09-09T07:02:12.214269Z","steps":["trace[1391814673] 'read index received'  (duration: 66.594774ms)","trace[1391814673] 'applied index is now lower than readState.Index'  (duration: 148.517916ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T07:02:12.214401Z","caller":"traceutil/trace.go:171","msg":"trace[288356679] transaction","detail":"{read_only:false; response_revision:21002; number_of_response:1; }","duration":"217.303262ms","start":"2026-09-09T07:02:11.99704Z","end":"2026-09-09T07:02:12.214343Z","steps":["trace[288356679] 'process raft request'  (duration: 217.085536ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T07:02:12.21465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.474879ms","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-09T07:02:12.214725Z","caller":"traceutil/trace.go:171","msg":"trace[535789024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21002; }","duration":"215.589851ms","start":"2026-09-09T07:02:11.999121Z","end":"2026-09-09T07:02:12.214711Z","steps":["trace[535789024] 'agreement among raft nodes before linearized reading'  (duration: 215.396626ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T07:02:12.214939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.916754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-09-09T07:02:12.215028Z","caller":"traceutil/trace.go:171","msg":"trace[486941254] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:21002; }","duration":"184.040667ms","start":"2026-09-09T07:02:12.030966Z","end":"2026-09-09T07:02:12.215007Z","steps":["trace[486941254] 'agreement among raft nodes before linearized reading'  (duration: 183.73647ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T07:02:12.87163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.408936ms","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-09T07:02:12.871753Z","caller":"traceutil/trace.go:171","msg":"trace[245498260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21007; }","duration":"127.59698ms","start":"2026-09-09T07:02:12.74413Z","end":"2026-09-09T07:02:12.871727Z","steps":["trace[245498260] 'range keys from in-memory index tree'  (duration: 127.15512ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:02:13.083204Z","caller":"traceutil/trace.go:171","msg":"trace[1208422885] transaction","detail":"{read_only:false; response_revision:21008; number_of_response:1; }","duration":"205.461546ms","start":"2026-09-09T07:02:12.877718Z","end":"2026-09-09T07:02:13.083179Z","steps":["trace[1208422885] 'process raft request'  (duration: 205.320662ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:02:13.123212Z","caller":"traceutil/trace.go:171","msg":"trace[127648891] linearizableReadLoop","detail":"{readStateIndex:21719; appliedIndex:21717; }","duration":"170.889078ms","start":"2026-09-09T07:02:12.95229Z","end":"2026-09-09T07:02:13.123179Z","steps":["trace[127648891] 'read index received'  (duration: 130.803378ms)","trace[127648891] 'applied index is now lower than readState.Index'  (duration: 40.08441ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T07:02:13.123448Z","caller":"traceutil/trace.go:171","msg":"trace[653941411] transaction","detail":"{read_only:false; response_revision:21009; number_of_response:1; }","duration":"244.901011ms","start":"2026-09-09T07:02:12.878512Z","end":"2026-09-09T07:02:13.123413Z","steps":["trace[653941411] 'process raft request'  (duration: 244.493101ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T07:02:13.123529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.218178ms","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-09T07:02:13.123574Z","caller":"traceutil/trace.go:171","msg":"trace[1883996391] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21009; }","duration":"171.289999ms","start":"2026-09-09T07:02:12.952273Z","end":"2026-09-09T07:02:13.123563Z","steps":["trace[1883996391] 'agreement among raft nodes before linearized reading'  (duration: 171.031012ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:04:22.669835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19837}
{"level":"info","ts":"2026-09-09T07:04:22.796982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19837,"took":"122.873493ms","hash":611120592,"current-db-size-bytes":55640064,"current-db-size":"56 MB","current-db-size-in-use-bytes":30064640,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T07:04:22.797039Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":611120592,"revision":19837,"compact-revision":17462}
{"level":"warn","ts":"2026-09-09T07:05:59.210963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.169607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-09-09T07:05:59.211119Z","caller":"traceutil/trace.go:171","msg":"trace[368106424] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:23452; }","duration":"146.31626ms","start":"2026-09-09T07:05:59.064761Z","end":"2026-09-09T07:05:59.211077Z","steps":["trace[368106424] 'range keys from in-memory index tree'  (duration: 145.997183ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T07:05:59.211225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.748231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-09-09T07:05:59.211283Z","caller":"traceutil/trace.go:171","msg":"trace[283973216] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:23452; }","duration":"265.855204ms","start":"2026-09-09T07:05:58.945415Z","end":"2026-09-09T07:05:59.21127Z","steps":["trace[283973216] 'range keys from in-memory index tree'  (duration: 265.577157ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:08:23.933043Z","caller":"traceutil/trace.go:171","msg":"trace[926838823] transaction","detail":"{read_only:false; response_revision:24822; number_of_response:1; }","duration":"172.004315ms","start":"2026-09-09T07:08:23.761Z","end":"2026-09-09T07:08:23.933004Z","steps":["trace[926838823] 'process raft request'  (duration: 161.717105ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T07:09:22.677492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22056}
{"level":"info","ts":"2026-09-09T07:09:22.792951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22056,"took":"111.74868ms","hash":187864856,"current-db-size-bytes":56061952,"current-db-size":"56 MB","current-db-size-in-use-bytes":43171840,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-09-09T07:09:22.793036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":187864856,"revision":22056,"compact-revision":19837}
{"level":"info","ts":"2026-09-09T07:13:52.908137Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006dfa.wal"}
{"level":"info","ts":"2026-09-09T07:14:22.686604Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25258}
{"level":"info","ts":"2026-09-09T07:14:22.839282Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25258,"took":"148.477124ms","hash":4157820059,"current-db-size-bytes":56061952,"current-db-size":"56 MB","current-db-size-in-use-bytes":30281728,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T07:14:22.839349Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4157820059,"revision":25258,"compact-revision":22056}